builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-029 starttime: 1480202617.54 results: success (0) buildid: 20161126152319 builduid: 8c442cc58c234e9a9f5c8936be09c308 revision: 873a10f77413394e7e4c2374ffb966e96b533ca6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:37.541856) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:37.542286) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:37.542575) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:37.571406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:37.571709) ========= 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=c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-26 15:23:38-- 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% 42.3M=0s 2016-11-26 15:23:38 (42.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109991 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:37.699057) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:37.699511) ========= 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=c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017420 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:37.785094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-26 15:23:37.785438) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 873a10f77413394e7e4c2374ffb966e96b533ca6 --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 873a10f77413394e7e4c2374ffb966e96b533ca6 --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=c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-26 15:23:38,494 truncating revision to first 12 chars 2016-11-26 15:23:38,494 Setting DEBUG logging. 2016-11-26 15:23:38,494 attempt 1/10 2016-11-26 15:23:38,494 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/873a10f77413?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-26 15:23:39,312 unpacking tar archive at: mozilla-inbound-873a10f77413/testing/mozharness/ program finished with exit code 0 elapsedTime=1.120964 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-26 15:23:38.923356) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:38.923646) ========= script_repo_revision: 873a10f77413394e7e4c2374ffb966e96b533ca6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:38.924069) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:38.924352) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:38.933443) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-26 15:23:38.933710) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:23:39 INFO - MultiFileLogger online at 20161126 15:23:39 in /builds/slave/test 15:23:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:23:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:23:39 INFO - {'append_to_log': False, 15:23:39 INFO - 'base_work_dir': '/builds/slave/test', 15:23:39 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:23:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:23:39 INFO - 'branch': 'Mozilla-Inbound', 15:23:39 INFO - 'buildbot_json_path': 'buildprops.json', 15:23:39 INFO - 'config_files': ('talos/linux_config.py',), 15:23:39 INFO - 'default_actions': ('clobber', 15:23:39 INFO - 'read-buildbot-config', 15:23:39 INFO - 'download-and-extract', 15:23:39 INFO - 'populate-webroot', 15:23:39 INFO - 'create-virtualenv', 15:23:39 INFO - 'install', 15:23:39 INFO - 'run-tests'), 15:23:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:23:39 INFO - 'download_minidump_stackwalk': True, 15:23:39 INFO - 'download_symbols': 'ondemand', 15:23:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:23:39 INFO - 'tooltool.py': '/tools/tooltool.py', 15:23:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:23:39 INFO - '/tools/misc-python/virtualenv.py')}, 15:23:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:23:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:23:39 INFO - 'installer_path': 'installer.exe', 15:23:39 INFO - 'log_level': 'info', 15:23:39 INFO - 'log_name': 'talos', 15:23:39 INFO - 'log_to_console': True, 15:23:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:23:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:23:39 INFO - 'opt_config_files': (), 15:23:39 INFO - 'pip_index': False, 15:23:39 INFO - 'sps_profile': False, 15:23:39 INFO - 'sps_profile_interval': 0, 15:23:39 INFO - 'suite': 'dromaeojs', 15:23:39 INFO - 'system_bits': '32', 15:23:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:23:39 INFO - 'title': 'talos-linux64-ix-029', 15:23:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:23:39 INFO - 'use_talos_json': True, 15:23:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:23:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:23:39 INFO - 'work_dir': 'build'} 15:23:39 INFO - [mozharness: 2016-11-26 23:23:39.750131Z] Running clobber step. 15:23:39 INFO - Running pre-action listener: _resource_record_pre_action 15:23:39 INFO - Running main action method: clobber 15:23:39 INFO - rmtree: /builds/slave/test/build 15:23:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:23:40 INFO - Running post-action listener: _resource_record_post_action 15:23:40 INFO - [mozharness: 2016-11-26 23:23:40.218436Z] Finished clobber step (success) 15:23:40 INFO - [mozharness: 2016-11-26 23:23:40.218534Z] Running read-buildbot-config step. 15:23:40 INFO - Running pre-action listener: _resource_record_pre_action 15:23:40 INFO - Running main action method: read_buildbot_config 15:23:40 INFO - Using buildbot properties: 15:23:40 INFO - { 15:23:40 INFO - "project": "", 15:23:40 INFO - "product": "firefox", 15:23:40 INFO - "script_repo_revision": "production", 15:23:40 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 15:23:40 INFO - "repository": "", 15:23:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 15:23:40 INFO - "buildid": "20161126152319", 15:23:40 INFO - "stage_platform": "linux64-pgo", 15:23:40 INFO - "basedir": "/builds/slave/test", 15:23:40 INFO - "buildnumber": 2161, 15:23:40 INFO - "platform": "ubuntu64_hw", 15:23:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:23:40 INFO - "slavebuilddir": "test", 15:23:40 INFO - "branch": "mozilla-inbound", 15:23:40 INFO - "revision": "873a10f77413394e7e4c2374ffb966e96b533ca6", 15:23:40 INFO - "slavename": "talos-linux64-ix-029", 15:23:40 INFO - "builduid": "8c442cc58c234e9a9f5c8936be09c308", 15:23:40 INFO - "repo_path": "integration/mozilla-inbound" 15:23:40 INFO - } 15:23:40 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 15:23:40 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 15:23:40 INFO - Running post-action listener: _resource_record_post_action 15:23:40 INFO - [mozharness: 2016-11-26 23:23:40.220871Z] Finished read-buildbot-config step (success) 15:23:40 INFO - [mozharness: 2016-11-26 23:23:40.220958Z] Running download-and-extract step. 15:23:40 INFO - Running pre-action listener: _resource_record_pre_action 15:23:40 INFO - Running main action method: download_and_extract 15:23:40 INFO - mkdir: /builds/slave/test/build/tests 15:23: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')]} 15:23:40 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:23:40 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:23:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:23:40 INFO - Downloaded 1361 bytes. 15:23:40 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:23:40 INFO - Using the following test package requirements: 15:23:40 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:23:40 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:23:40 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:23:40 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:40 INFO - u'jsshell-linux-x86_64.zip'], 15:23:40 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:23:40 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:23:40 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:23:40 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:23:40 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:23:40 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:23:40 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:23:40 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/1480192204/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:23:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:23:40 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:23:40 INFO - Http code: 200 15:23:40 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 15:23:40 INFO - x-amz-cf-id: CrvatYT0bLCvew_HTmOyrLN5jwxKPbZwMBwbH-m7OOcjnTGy95Sf_g== 15:23:40 INFO - x-amz-replication-status: COMPLETED 15:23:40 INFO - x-amz-version-id: HjoKhwMB359BkrH7ipMVtHNhHqXixkx0 15:23:42 INFO - Expected file size: 21771581 15:23:42 INFO - Obtained file size: 21771581 15:23:47 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:23:47 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/1480192204/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:23:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:23:47 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:23:47 INFO - Http code: 200 15:23:47 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 15:23:47 INFO - x-amz-cf-id: pSofvCkfNghUbX-MHrhk4SDE-dJ01U8Jk8TTJESK02x2oE_44qQdAw== 15:23:47 INFO - x-amz-replication-status: COMPLETED 15:23:47 INFO - x-amz-version-id: HjoKhwMB359BkrH7ipMVtHNhHqXixkx0 15:23:47 INFO - Expected file size: 21771581 15:23:47 INFO - Obtained file size: 21771581 15:23:52 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/1480192204/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 15:23:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:23:52 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:23:52 INFO - Http code: 200 15:23:52 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 15:23:52 INFO - x-amz-cf-id: RqD_pQ2ghe-fs7BZ3HwSusYuTr83-2rf5AezE_JIrpAiYKcHvt8XdQ== 15:23:52 INFO - x-amz-replication-status: COMPLETED 15:23:52 INFO - x-amz-version-id: kvEazRc1fNZJFG4mD_jLDLB5W1A9Z1cZ 15:23:55 INFO - Expected file size: 14409702 15:23:55 INFO - Obtained file size: 14409702 15:23:55 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')]} 15:23:55 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:23:55 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:23:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:24:00 INFO - Downloaded 59820159 bytes. 15:24:00 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:24:00 INFO - mkdir: /builds/slave/test/properties 15:24:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:24:00 INFO - Writing to file /builds/slave/test/properties/build_url 15:24:00 INFO - Contents: 15:24:00 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:24:00 INFO - Running post-action listener: _resource_record_post_action 15:24:00 INFO - Running post-action listener: set_extra_try_arguments 15:24:00 INFO - [mozharness: 2016-11-26 23:24:00.920972Z] Finished download-and-extract step (success) 15:24:00 INFO - [mozharness: 2016-11-26 23:24:00.921197Z] Running populate-webroot step. 15:24:00 INFO - Running pre-action listener: _resource_record_pre_action 15:24:00 INFO - Running main action method: populate_webroot 15:24:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:24:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:24:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:24:00 INFO - '--tppagecycles', 15:24:00 INFO - '7'], 15:24:00 INFO - 'tests': ['tsvgm']}}, 15:24:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:24:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:24:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:24:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:24:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:24:00 INFO - 'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:24:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:24:00 INFO - 'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['damp', 'tps']}, 15:24:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:24:00 INFO - 'tests': ['damp', 'tps']}, 15:24:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['dromaeo_dom']}, 15:24:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:24:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['basic_compositor_video']}, 15:24:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:24:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['a11yr', 15:24:00 INFO - 'ts_paint', 15:24:00 INFO - 'tpaint', 15:24:00 INFO - 'sessionrestore', 15:24:00 INFO - 'sessionrestore_no_auto_restore', 15:24:00 INFO - 'tabpaint']}, 15:24:00 INFO - 'other-e10s': {'tests': ['a11yr', 15:24:00 INFO - 'ts_paint', 15:24:00 INFO - 'tpaint', 15:24:00 INFO - 'sessionrestore', 15:24:00 INFO - 'sessionrestore_no_auto_restore', 15:24:00 INFO - 'tabpaint']}, 15:24:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:24:00 INFO - 'ts_paint', 15:24:00 INFO - 'tpaint', 15:24:00 INFO - 'sessionrestore', 15:24:00 INFO - 'sessionrestore_no_auto_restore', 15:24:00 INFO - 'tabpaint']}, 15:24:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:24:00 INFO - 'ts_paint', 15:24:00 INFO - 'tpaint', 15:24:00 INFO - 'sessionrestore', 15:24:00 INFO - 'sessionrestore_no_auto_restore', 15:24:00 INFO - 'tabpaint']}, 15:24:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['a11yr', 15:24:00 INFO - 'ts_paint', 15:24:00 INFO - 'tpaint', 15:24:00 INFO - 'sessionrestore', 15:24:00 INFO - 'sessionrestore_no_auto_restore', 15:24:00 INFO - 'tabpaint']}, 15:24:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['a11yr', 15:24:00 INFO - 'ts_paint', 15:24:00 INFO - 'tpaint', 15:24:00 INFO - 'sessionrestore', 15:24:00 INFO - 'sessionrestore_no_auto_restore', 15:24:00 INFO - 'tabpaint']}, 15:24:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['tsvgx', 15:24:00 INFO - 'tsvgr_opacity', 15:24:00 INFO - 'tart', 15:24:00 INFO - 'tscrollx', 15:24:00 INFO - 'cart', 15:24:00 INFO - 'tsvg_static']}, 15:24:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:24:00 INFO - 'tsvgr_opacity', 15:24:00 INFO - 'tart', 15:24:00 INFO - 'tscrollx', 15:24:00 INFO - 'cart', 15:24:00 INFO - 'tsvg_static']}, 15:24:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:24:00 INFO - 'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['tp5o']}, 15:24:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:24:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:24:00 INFO - 'talos_options': ['--disable-e10s', 15:24:00 INFO - '--xperf_path', 15:24:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:00 INFO - 'tests': ['tp5n']}, 15:24:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:24:00 INFO - 'talos_options': ['--xperf_path', 15:24:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:00 INFO - 'tests': ['tp5n']}}, 15:24:00 INFO - 'talos.zip': {'path': '', 15:24:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:24:00 INFO - Running post-action listener: _resource_record_post_action 15:24:00 INFO - [mozharness: 2016-11-26 23:24:00.941793Z] Finished populate-webroot step (success) 15:24:00 INFO - [mozharness: 2016-11-26 23:24:00.941880Z] Running create-virtualenv step. 15:24:00 INFO - Running pre-action listener: _resource_record_pre_action 15:24:00 INFO - Running main action method: create_virtualenv 15:24:00 INFO - Creating virtualenv /builds/slave/test/build/venv 15:24:00 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 15:24:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:24:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:24:01 INFO - Using real prefix '/usr' 15:24:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:24:01 INFO - Installing distribute.............................................................................................................................................................................................done. 15:24:03 INFO - Installing pip.................done. 15:24:03 INFO - Return code: 0 15:24:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:24:03 INFO - Reading from file tmpfile_stdout 15:24:03 INFO - Output received: 15:24:03 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) 15:24:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:24:03 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')]} 15:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:03 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')]} 15:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:03 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 0x7fb79a3b0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x208d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211bfc0>, '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 0x211cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211d350>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617', '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 15:24:03 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 15:24:03 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 15:24:03 INFO - Using env: {'DISPLAY': ':0', 15:24:03 INFO - 'HOME': '/home/cltbld', 15:24:03 INFO - 'LANG': 'en_US.UTF-8', 15:24:03 INFO - 'LANGUAGE': 'en_US:en', 15:24:03 INFO - 'LOGNAME': 'cltbld', 15:24:03 INFO - 'MAIL': '/var/mail/cltbld', 15:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:03 INFO - 'MOZ_NO_REMOTE': '1', 15:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:03 INFO - 'NO_EM_RESTART': '1', 15:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:03 INFO - 'PWD': '/builds/slave/test', 15:24:03 INFO - 'SHELL': '/bin/bash', 15:24:03 INFO - 'SHLVL': '1', 15:24:03 INFO - 'TERM': 'linux', 15:24:03 INFO - 'TMOUT': '86400', 15:24:03 INFO - 'USER': 'cltbld', 15:24:03 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617', 15:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:03 INFO - '_': '/tools/buildbot/bin/python'} 15:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:03 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 15:24:03 INFO - Cleaning up... 15:24:03 INFO - Return code: 0 15:24:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:24:03 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')]} 15:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:03 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')]} 15:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:03 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 0x7fb79a3b0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x208d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211bfc0>, '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 0x211cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211d350>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617', '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 15:24:03 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 15:24:03 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 15:24:03 INFO - Using env: {'DISPLAY': ':0', 15:24:03 INFO - 'HOME': '/home/cltbld', 15:24:03 INFO - 'LANG': 'en_US.UTF-8', 15:24:03 INFO - 'LANGUAGE': 'en_US:en', 15:24:03 INFO - 'LOGNAME': 'cltbld', 15:24:03 INFO - 'MAIL': '/var/mail/cltbld', 15:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:03 INFO - 'MOZ_NO_REMOTE': '1', 15:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:03 INFO - 'NO_EM_RESTART': '1', 15:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:03 INFO - 'PWD': '/builds/slave/test', 15:24:03 INFO - 'SHELL': '/bin/bash', 15:24:03 INFO - 'SHLVL': '1', 15:24:03 INFO - 'TERM': 'linux', 15:24:03 INFO - 'TMOUT': '86400', 15:24:03 INFO - 'USER': 'cltbld', 15:24:03 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617', 15:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:03 INFO - '_': '/tools/buildbot/bin/python'} 15:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:04 INFO - Downloading/unpacking psutil>=3.1.1 15:24:04 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 15:24:04 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 15:24:04 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 15:24:04 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 15:24:04 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 15:24:04 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 15:24:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:24:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:06 INFO - Installing collected packages: psutil 15:24:06 INFO - Running setup.py install for psutil 15:24:06 INFO - building 'psutil._psutil_linux' extension 15:24:06 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 15:24:06 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 15:24:06 INFO - building 'psutil._psutil_posix' extension 15:24:06 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 15:24:06 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 15:24:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:06 INFO - Successfully installed psutil 15:24:06 INFO - Cleaning up... 15:24:06 INFO - Return code: 0 15:24:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb79a3b0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x208d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211bfc0>, '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 0x211cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211d350>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617', '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 15:24:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:24:06 INFO - Using env: {'DISPLAY': ':0', 15:24:06 INFO - 'HOME': '/home/cltbld', 15:24:06 INFO - 'LANG': 'en_US.UTF-8', 15:24:06 INFO - 'LANGUAGE': 'en_US:en', 15:24:06 INFO - 'LOGNAME': 'cltbld', 15:24:06 INFO - 'MAIL': '/var/mail/cltbld', 15:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:06 INFO - 'MOZ_NO_REMOTE': '1', 15:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:06 INFO - 'NO_EM_RESTART': '1', 15:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:06 INFO - 'PWD': '/builds/slave/test', 15:24:06 INFO - 'SHELL': '/bin/bash', 15:24:06 INFO - 'SHLVL': '1', 15:24:06 INFO - 'TERM': 'linux', 15:24:06 INFO - 'TMOUT': '86400', 15:24:06 INFO - 'USER': 'cltbld', 15:24:06 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617', 15:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:06 INFO - '_': '/tools/buildbot/bin/python'} 15:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:24:06 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 15:24:06 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 15:24:06 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 15:24:06 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 15:24:06 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 15:24:06 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 15:24:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:24:08 INFO - Installing collected packages: mozsystemmonitor 15:24:08 INFO - Running setup.py install for mozsystemmonitor 15:24:09 INFO - Successfully installed mozsystemmonitor 15:24:09 INFO - Cleaning up... 15:24:09 INFO - Return code: 0 15:24:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb79a3b0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x208d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211bfc0>, '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 0x211cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211d350>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617', '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 15:24:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:24:09 INFO - Using env: {'DISPLAY': ':0', 15:24:09 INFO - 'HOME': '/home/cltbld', 15:24:09 INFO - 'LANG': 'en_US.UTF-8', 15:24:09 INFO - 'LANGUAGE': 'en_US:en', 15:24:09 INFO - 'LOGNAME': 'cltbld', 15:24:09 INFO - 'MAIL': '/var/mail/cltbld', 15:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:09 INFO - 'MOZ_NO_REMOTE': '1', 15:24:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:09 INFO - 'NO_EM_RESTART': '1', 15:24:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:09 INFO - 'PWD': '/builds/slave/test', 15:24:09 INFO - 'SHELL': '/bin/bash', 15:24:09 INFO - 'SHLVL': '1', 15:24:09 INFO - 'TERM': 'linux', 15:24:09 INFO - 'TMOUT': '86400', 15:24:09 INFO - 'USER': 'cltbld', 15:24:09 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617', 15:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:09 INFO - '_': '/tools/buildbot/bin/python'} 15:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:09 INFO - Downloading/unpacking jsonschema==2.5.1 15:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:24:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:24:11 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 15:24:11 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 15:24:11 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 15:24:11 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 15:24:11 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 15:24:11 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 15:24:11 INFO - Downloading functools32-3.2.3-2.tar.gz 15:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:24:11 INFO - warning: no files found matching '*.txt' 15:24:11 INFO - no previously-included directories found matching 'build' 15:24:11 INFO - no previously-included directories found matching 'dist' 15:24:11 INFO - no previously-included directories found matching '.git*' 15:24:11 INFO - Installing collected packages: jsonschema, functools32 15:24:11 INFO - Running setup.py install for functools32 15:24:11 INFO - warning: no files found matching '*.txt' 15:24:11 INFO - no previously-included directories found matching 'build' 15:24:11 INFO - no previously-included directories found matching 'dist' 15:24:11 INFO - no previously-included directories found matching '.git*' 15:24:11 INFO - Successfully installed jsonschema functools32 15:24:11 INFO - Cleaning up... 15:24:11 INFO - Return code: 0 15:24:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:24:11 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')]} 15:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:11 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')]} 15:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:11 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 0x7fb79a3b0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x208d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211bfc0>, '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 0x211cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211d350>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617', '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 15:24:11 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 15:24:11 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 15:24:11 INFO - Using env: {'DISPLAY': ':0', 15:24:11 INFO - 'HOME': '/home/cltbld', 15:24:11 INFO - 'LANG': 'en_US.UTF-8', 15:24:11 INFO - 'LANGUAGE': 'en_US:en', 15:24:11 INFO - 'LOGNAME': 'cltbld', 15:24:11 INFO - 'MAIL': '/var/mail/cltbld', 15:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:11 INFO - 'MOZ_NO_REMOTE': '1', 15:24:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:11 INFO - 'NO_EM_RESTART': '1', 15:24:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:11 INFO - 'PWD': '/builds/slave/test', 15:24:11 INFO - 'SHELL': '/bin/bash', 15:24:11 INFO - 'SHLVL': '1', 15:24:11 INFO - 'TERM': 'linux', 15:24:11 INFO - 'TMOUT': '86400', 15:24:11 INFO - 'USER': 'cltbld', 15:24:11 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617', 15:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:11 INFO - '_': '/tools/buildbot/bin/python'} 15:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:24:11 INFO - Cleaning up... 15:24:11 INFO - Return code: 0 15:24:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:24:11 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')]} 15:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:11 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')]} 15:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:11 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 0x7fb79a3b0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x208d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211bfc0>, '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 0x211cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211d350>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617', '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 15:24:11 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 15:24:11 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 15:24:11 INFO - Using env: {'DISPLAY': ':0', 15:24:11 INFO - 'HOME': '/home/cltbld', 15:24:11 INFO - 'LANG': 'en_US.UTF-8', 15:24:11 INFO - 'LANGUAGE': 'en_US:en', 15:24:11 INFO - 'LOGNAME': 'cltbld', 15:24:11 INFO - 'MAIL': '/var/mail/cltbld', 15:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:11 INFO - 'MOZ_NO_REMOTE': '1', 15:24:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:11 INFO - 'NO_EM_RESTART': '1', 15:24:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:11 INFO - 'PWD': '/builds/slave/test', 15:24:11 INFO - 'SHELL': '/bin/bash', 15:24:11 INFO - 'SHLVL': '1', 15:24:11 INFO - 'TERM': 'linux', 15:24:11 INFO - 'TMOUT': '86400', 15:24:11 INFO - 'USER': 'cltbld', 15:24:11 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617', 15:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:11 INFO - '_': '/tools/buildbot/bin/python'} 15:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:12 INFO - Downloading/unpacking blobuploader==1.2.4 15:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:14 INFO - Downloading blobuploader-1.2.4.tar.gz 15:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:24:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:24:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:14 INFO - Downloading docopt-0.6.1.tar.gz 15:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:24:14 INFO - Installing collected packages: blobuploader, requests, docopt 15:24:14 INFO - Running setup.py install for blobuploader 15:24:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:24:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:24:14 INFO - Running setup.py install for requests 15:24:15 INFO - Running setup.py install for docopt 15:24:15 INFO - Successfully installed blobuploader requests docopt 15:24:15 INFO - Cleaning up... 15:24:15 INFO - Return code: 0 15:24:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24: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')]} 15:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24: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')]} 15:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:15 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 0x7fb79a3b0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x208d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211bfc0>, '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 0x211cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211d350>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617', '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 15:24:15 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 15:24:15 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 15:24:15 INFO - Using env: {'DISPLAY': ':0', 15:24:15 INFO - 'HOME': '/home/cltbld', 15:24:15 INFO - 'LANG': 'en_US.UTF-8', 15:24:15 INFO - 'LANGUAGE': 'en_US:en', 15:24:15 INFO - 'LOGNAME': 'cltbld', 15:24:15 INFO - 'MAIL': '/var/mail/cltbld', 15:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:15 INFO - 'MOZ_NO_REMOTE': '1', 15:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:15 INFO - 'NO_EM_RESTART': '1', 15:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:15 INFO - 'PWD': '/builds/slave/test', 15:24:15 INFO - 'SHELL': '/bin/bash', 15:24:15 INFO - 'SHLVL': '1', 15:24:15 INFO - 'TERM': 'linux', 15:24:15 INFO - 'TMOUT': '86400', 15:24:15 INFO - 'USER': 'cltbld', 15:24:15 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617', 15:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:15 INFO - '_': '/tools/buildbot/bin/python'} 15:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:24:15 INFO - Running setup.py (path:/tmp/pip-aYsglv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:24:15 INFO - Running setup.py (path:/tmp/pip-B2sirS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:24:15 INFO - Running setup.py (path:/tmp/pip-bDCBsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:24:15 INFO - Running setup.py (path:/tmp/pip-J4yrUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:24:16 INFO - Running setup.py (path:/tmp/pip-A4GBS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:24:16 INFO - Running setup.py (path:/tmp/pip-y615tL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:24:16 INFO - Running setup.py (path:/tmp/pip-4hs_83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:24:16 INFO - Running setup.py (path:/tmp/pip-JViThy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:24:16 INFO - Running setup.py (path:/tmp/pip-0JG63m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:24:16 INFO - Running setup.py (path:/tmp/pip-aFJ4p1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:24:16 INFO - Running setup.py (path:/tmp/pip-cOM3WD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:24:16 INFO - Running setup.py (path:/tmp/pip-JU9vdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:24:16 INFO - Running setup.py (path:/tmp/pip-Ogw1oR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:24:16 INFO - Running setup.py (path:/tmp/pip-UNclzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:16 INFO - Running setup.py (path:/tmp/pip-Copdnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:24:16 INFO - Running setup.py (path:/tmp/pip-o5CJe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:24:16 INFO - Running setup.py (path:/tmp/pip-xYZKND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:24:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:24:16 INFO - Running setup.py install for manifestparser 15:24:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Running setup.py install for mozcrash 15:24:17 INFO - Running setup.py install for mozdebug 15:24:17 INFO - Running setup.py install for mozdevice 15:24:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Running setup.py install for mozfile 15:24:17 INFO - Running setup.py install for mozhttpd 15:24:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Running setup.py install for mozinfo 15:24:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Running setup.py install for mozInstall 15:24:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Running setup.py install for mozleak 15:24:17 INFO - Running setup.py install for mozlog 15:24:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Running setup.py install for moznetwork 15:24:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:24:18 INFO - Running setup.py install for mozprocess 15:24:18 INFO - Running setup.py install for mozprofile 15:24:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:24:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:24:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:24:18 INFO - Running setup.py install for mozrunner 15:24:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:24:18 INFO - Running setup.py install for mozscreenshot 15:24:18 INFO - Running setup.py install for moztest 15:24:18 INFO - Running setup.py install for mozversion 15:24:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:24:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:24:18 INFO - Cleaning up... 15:24:18 INFO - Return code: 0 15:24:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:18 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 0x7fb79a3b0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x208d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211bfc0>, '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 0x211cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211d350>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617', '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 15:24:18 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 15:24:18 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 15:24:18 INFO - Using env: {'DISPLAY': ':0', 15:24:18 INFO - 'HOME': '/home/cltbld', 15:24:18 INFO - 'LANG': 'en_US.UTF-8', 15:24:18 INFO - 'LANGUAGE': 'en_US:en', 15:24:18 INFO - 'LOGNAME': 'cltbld', 15:24:18 INFO - 'MAIL': '/var/mail/cltbld', 15:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:18 INFO - 'MOZ_NO_REMOTE': '1', 15:24:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:18 INFO - 'NO_EM_RESTART': '1', 15:24:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:18 INFO - 'PWD': '/builds/slave/test', 15:24:18 INFO - 'SHELL': '/bin/bash', 15:24:18 INFO - 'SHLVL': '1', 15:24:18 INFO - 'TERM': 'linux', 15:24:18 INFO - 'TMOUT': '86400', 15:24:18 INFO - 'USER': 'cltbld', 15:24:18 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617', 15:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:18 INFO - '_': '/tools/buildbot/bin/python'} 15:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:24:18 INFO - Running setup.py (path:/tmp/pip-lljgnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:24:19 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:24:19 INFO - Running setup.py (path:/tmp/pip-Q0BLvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:24:19 INFO - Running setup.py (path:/tmp/pip-rlvDdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:24:19 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:24:19 INFO - Running setup.py (path:/tmp/pip-NZAzW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:24:19 INFO - Running setup.py (path:/tmp/pip-M1SNTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:24:19 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:24:19 INFO - Running setup.py (path:/tmp/pip-cSgOXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:24:19 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:24:19 INFO - Running setup.py (path:/tmp/pip-g99cqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:24:19 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:24:19 INFO - Running setup.py (path:/tmp/pip-NbvcqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:24:19 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:24:19 INFO - Running setup.py (path:/tmp/pip-mLNple-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:24:19 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:24:19 INFO - Running setup.py (path:/tmp/pip-KXoqGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:24:19 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:24:19 INFO - Running setup.py (path:/tmp/pip-1N6HM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:24:19 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:24:19 INFO - Running setup.py (path:/tmp/pip-jWCDYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:24:19 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:24:19 INFO - Running setup.py (path:/tmp/pip-828dgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:24:19 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:24:19 INFO - Running setup.py (path:/tmp/pip-3kIuwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:19 INFO - Running setup.py (path:/tmp/pip-sO7nBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:20 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)) 15:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:24:20 INFO - Running setup.py (path:/tmp/pip-jYCI7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:24:20 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)) 15:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:24:20 INFO - Running setup.py (path:/tmp/pip-u1PwF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:24:20 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)) 15:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:24:20 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)) 15:24:20 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:24:20 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:24:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:24:20 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 15:24:20 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 15:24:20 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 15:24:20 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 15:24:20 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 15:24:20 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 15:24:22 INFO - Downloading blessings-1.6.tar.gz 15:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:24:22 INFO - Installing collected packages: blessings 15:24:22 INFO - Running setup.py install for blessings 15:24:22 INFO - Successfully installed blessings 15:24:22 INFO - Cleaning up... 15:24:22 INFO - Return code: 0 15:24:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:24:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:24:22 INFO - Reading from file tmpfile_stdout 15:24:22 INFO - Current package versions: 15:24:22 INFO - argparse == 1.2.1 15:24:22 INFO - blessings == 1.6 15:24:22 INFO - blobuploader == 1.2.4 15:24:22 INFO - docopt == 0.6.1 15:24:22 INFO - functools32 == 3.2.3-2 15:24:22 INFO - jsonschema == 2.5.1 15:24:22 INFO - manifestparser == 1.1 15:24:22 INFO - mozInstall == 1.12 15:24:22 INFO - mozcrash == 1.0 15:24:22 INFO - mozdebug == 0.1 15:24:22 INFO - mozdevice == 0.49 15:24:22 INFO - mozfile == 1.2 15:24:22 INFO - mozhttpd == 0.7 15:24:22 INFO - mozinfo == 0.9 15:24:22 INFO - mozleak == 0.1 15:24:22 INFO - mozlog == 3.4 15:24:22 INFO - moznetwork == 0.27 15:24:22 INFO - mozprocess == 0.23 15:24:22 INFO - mozprofile == 0.28 15:24:22 INFO - mozrunner == 6.13 15:24:22 INFO - mozscreenshot == 0.1 15:24:22 INFO - mozsystemmonitor == 0.3 15:24:22 INFO - moztest == 0.7 15:24:22 INFO - mozversion == 1.4 15:24:22 INFO - psutil == 3.1.1 15:24:22 INFO - requests == 1.2.3 15:24:22 INFO - wsgiref == 0.1.2 15:24:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24:22 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')]} 15:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:22 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')]} 15:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:22 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 0x7fb79a3b0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x208d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211bfc0>, '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 0x211cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211d350>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617', '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 15:24:22 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 15:24:22 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 15:24:22 INFO - Using env: {'DISPLAY': ':0', 15:24:22 INFO - 'HOME': '/home/cltbld', 15:24:22 INFO - 'LANG': 'en_US.UTF-8', 15:24:22 INFO - 'LANGUAGE': 'en_US:en', 15:24:22 INFO - 'LOGNAME': 'cltbld', 15:24:22 INFO - 'MAIL': '/var/mail/cltbld', 15:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:22 INFO - 'MOZ_NO_REMOTE': '1', 15:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:22 INFO - 'NO_EM_RESTART': '1', 15:24:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:22 INFO - 'PWD': '/builds/slave/test', 15:24:22 INFO - 'SHELL': '/bin/bash', 15:24:22 INFO - 'SHLVL': '1', 15:24:22 INFO - 'TERM': 'linux', 15:24:22 INFO - 'TMOUT': '86400', 15:24:22 INFO - 'USER': 'cltbld', 15:24:22 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617', 15:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:22 INFO - '_': '/tools/buildbot/bin/python'} 15:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 INFO - Cleaning up... 15:24:22 INFO - Return code: 0 15:24:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:24:22 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')]} 15:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:22 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')]} 15:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:22 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 0x7fb79a3b0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x208d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211bfc0>, '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 0x211cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211d350>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617', '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 15:24:22 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 15:24:22 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 15:24:22 INFO - Using env: {'DISPLAY': ':0', 15:24:22 INFO - 'HOME': '/home/cltbld', 15:24:22 INFO - 'LANG': 'en_US.UTF-8', 15:24:22 INFO - 'LANGUAGE': 'en_US:en', 15:24:22 INFO - 'LOGNAME': 'cltbld', 15:24:22 INFO - 'MAIL': '/var/mail/cltbld', 15:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:22 INFO - 'MOZ_NO_REMOTE': '1', 15:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:22 INFO - 'NO_EM_RESTART': '1', 15:24:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:22 INFO - 'PWD': '/builds/slave/test', 15:24:22 INFO - 'SHELL': '/bin/bash', 15:24:22 INFO - 'SHLVL': '1', 15:24:22 INFO - 'TERM': 'linux', 15:24:22 INFO - 'TMOUT': '86400', 15:24:22 INFO - 'USER': 'cltbld', 15:24:22 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617', 15:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:22 INFO - '_': '/tools/buildbot/bin/python'} 15:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:24:23 INFO - Cleaning up... 15:24:23 INFO - Return code: 0 15:24:23 INFO - Running post-action listener: _resource_record_post_action 15:24:23 INFO - Running post-action listener: _start_resource_monitoring 15:24:23 INFO - Starting resource monitoring. 15:24:23 INFO - [mozharness: 2016-11-26 23:24:23.106143Z] Finished create-virtualenv step (success) 15:24:23 INFO - [mozharness: 2016-11-26 23:24:23.106660Z] Running install step. 15:24:23 INFO - Running pre-action listener: _resource_record_pre_action 15:24:23 INFO - Running main action method: install 15:24:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:24:23 INFO - Reading from file tmpfile_stdout 15:24:23 INFO - Detecting whether we're running mozinstall >=1.0... 15:24:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:24:23 INFO - Reading from file tmpfile_stdout 15:24:23 INFO - Output received: 15:24:23 INFO - Usage: mozinstall [options] installer 15:24:23 INFO - Options: 15:24:23 INFO - -h, --help show this help message and exit 15:24:23 INFO - -d DEST, --destination=DEST 15:24:23 INFO - Directory to install application into. [default: 15:24:23 INFO - "/builds/slave/test"] 15:24:23 INFO - --app=APP Application being installed. [default: firefox] 15:24:23 INFO - mkdir: /builds/slave/test/build/application 15:24:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:24:40 INFO - Reading from file tmpfile_stdout 15:24:40 INFO - Output received: 15:24:40 INFO - /builds/slave/test/build/application/firefox/firefox 15:24:40 INFO - Running post-action listener: _resource_record_post_action 15:24:40 INFO - [mozharness: 2016-11-26 23:24:40.347617Z] Finished install step (success) 15:24:40 INFO - [mozharness: 2016-11-26 23:24:40.347888Z] Running run-tests step. 15:24:40 INFO - Running pre-action listener: _resource_record_pre_action 15:24:40 INFO - Running main action method: run_tests 15:24:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:24:40 INFO - Python 2.7.3 15:24:40 INFO - Return code: 0 15:24:40 INFO - grabbing minidump binary from tooltool 15:24: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')]} 15:24:40 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 0x211bfc0>, '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 0x211cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211d350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:24:40 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 15:24:40 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 15:24:40 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 15:24:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:24:40 INFO - Return code: 0 15:24:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:24:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:24:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:24:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:24:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:24:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:24:40 INFO - Using env: {'DISPLAY': ':0', 15:24:40 INFO - 'HOME': '/home/cltbld', 15:24:40 INFO - 'LANG': 'en_US.UTF-8', 15:24:40 INFO - 'LANGUAGE': 'en_US:en', 15:24:40 INFO - 'LOGNAME': 'cltbld', 15:24:40 INFO - 'MAIL': '/var/mail/cltbld', 15:24:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:24:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:40 INFO - 'MOZ_NO_REMOTE': '1', 15:24:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:24:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:40 INFO - 'NO_EM_RESTART': '1', 15:24:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:40 INFO - 'PWD': '/builds/slave/test', 15:24:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:24:40 INFO - 'SHELL': '/bin/bash', 15:24:40 INFO - 'SHLVL': '1', 15:24:40 INFO - 'TERM': 'linux', 15:24:40 INFO - 'TMOUT': '86400', 15:24:40 INFO - 'USER': 'cltbld', 15:24:40 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617', 15:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:40 INFO - '_': '/tools/buildbot/bin/python'} 15:24:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:24:40 INFO - mozversion application_buildid: 20161126123004 15:24:40 INFO - mozversion application_changeset: 873a10f77413394e7e4c2374ffb966e96b533ca6 15:24:40 INFO - mozversion application_display_name: Nightly 15:24:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:24:40 INFO - mozversion application_name: Firefox 15:24:40 INFO - mozversion application_remotingname: firefox 15:24:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:24:40 INFO - mozversion application_vendor: Mozilla 15:24:40 INFO - mozversion application_version: 53.0a1 15:24:40 INFO - mozversion platform_buildid: 20161126123004 15:24:40 INFO - mozversion platform_changeset: 873a10f77413394e7e4c2374ffb966e96b533ca6 15:24:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:24:40 INFO - mozversion platform_version: 53.0a1 15:24:40 INFO - using testdate: 1480202680 15:24:40 INFO - actual date: 1480202680 15:24:40 INFO - starting webserver on 'localhost:53923' 15:24:40 INFO - SUITE-START | Running 2 tests 15:24:40 INFO - TEST-START | dromaeo_css 15:24:40 INFO - operating with platform_type : linux_ 15:24:40 INFO - Initialising browser for dromaeo_css test... 15:24:40 INFO - TEST-INFO | started process 31746 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5tCfQe/profile http://localhost:53923/getInfo.html) 15:24:44 INFO - PROCESS | 31746 | __metrics Screen width/height:1600/1200 15:24:44 INFO - PROCESS | 31746 | colorDepth:24 15:24:44 INFO - PROCESS | 31746 | Browser inner width/height: 1024/697 15:24:44 INFO - PROCESS | 31746 | __metrics 15:24:45 INFO - PROCESS | 31746 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:24:45 INFO - PROCESS | 31746 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:24:46 INFO - PROCESS | 31746 | console.error: PushService: 15:24:46 INFO - PROCESS | 31746 | stateChangeProcessEnqueue: Error transitioning state 15:24:46 INFO - PROCESS | 31746 | UnknownError 15:24:46 INFO - TEST-INFO | 31746: exit 0 15:24:46 INFO - Browser initialized. 15:24:46 INFO - Running cycle 1/1 for dromaeo_css test... 15:24:46 INFO - TEST-INFO | started process 31829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5tCfQe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:24:58 INFO - PROCESS | 31829 | RSS: Main: 173953024 15:24:58 INFO - PROCESS | 31829 | 15:25:50 INFO - PROCESS | 31829 | 1480202750612 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] 15:28:01 INFO - PROCESS | 31829 | Cycle 1(1): loaded http://localhost:53923/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53923/tests/dromaeo/cssquery-ext.html) 15:28:02 INFO - PROCESS | 31829 | RSS: Main: 326311936 15:28:02 INFO - PROCESS | 31829 | 15:31:05 INFO - PROCESS | 31829 | Cycle 1(1): loaded http://localhost:53923/tests/dromaeo/cssquery-ext.html (next: http://localhost:53923/tests/dromaeo/cssquery-jquery.html) 15:31:06 INFO - PROCESS | 31829 | RSS: Main: 275681280 15:31:06 INFO - PROCESS | 31829 | 15:34:08 INFO - PROCESS | 31829 | Cycle 1(1): loaded http://localhost:53923/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53923/tests/dromaeo/cssquery-mootools.html) 15:34:08 INFO - PROCESS | 31829 | RSS: Main: 217403392 15:34:08 INFO - PROCESS | 31829 | 15:37:10 INFO - PROCESS | 31829 | Cycle 1(1): loaded http://localhost:53923/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53923/tests/dromaeo/cssquery-prototype.html) 15:37:11 INFO - PROCESS | 31829 | RSS: Main: 221093888 15:37:11 INFO - PROCESS | 31829 | 15:40:14 INFO - PROCESS | 31829 | Cycle 1(1): loaded http://localhost:53923/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53923/tests/dromaeo/cssquery-yui.html) 15:40:14 INFO - PROCESS | 31829 | RSS: Main: 218660864 15:40:14 INFO - PROCESS | 31829 | 15:43:18 INFO - PROCESS | 31829 | Cycle 1(1): loaded http://localhost:53923/tests/dromaeo/cssquery-yui.html (next: http://localhost:53923/tests/dromaeo/cssquery-dojo.html) 15:43:18 INFO - PROCESS | 31829 | RSS: Main: 315826176 15:43:18 INFO - PROCESS | 31829 | 15:43:18 INFO - PROCESS | 31829 | __start_tp_report 15:43:18 INFO - PROCESS | 31829 | _x_x_mozilla_page_load 15:43:18 INFO - PROCESS | 31829 | _x_x_mozilla_page_load_details 15:43:18 INFO - PROCESS | 31829 | |i|pagename|runs| 15:43:18 INFO - PROCESS | 31829 | |0;dojo.html;3082.1678146900335;3109.502479603264;3111.1133327001794;3137.5764271823296;3154.3218208085273;5231.921521177185;5317.255584218207;5319.281896943911;5361.624686271957;5367.033933891903;5250.054990101789;5289.814856480024;5304.416514183436;5326.121190003645;5383.111786555213;4799.5680388765;4834.903301933977;4835.395575553056;4853.733044682541;4870.951290487085;4823.831165909194;4935.259711043336;4936.901261974758;4941.925871111936;4976.427710813248;4910.1898186799135;4952.678075925053;4961.8015279388965;4966.87582810429;5011.072951503965;4744.715317080986;4788.377510923592;4790.784414701347;4801.4958429365115;4887.266909963499;4801.087793319293;4803.255495398219;4812.157872372356;4812.398450193726;4819.228923372279;5156.278121063054;5190.71451070191;5250.05499010178;5302.390225124122;5316.893662126736;5643.40744221859;5646.774129034875;5650.9152362714185;5652.0391533439415;5657.066584013633;5621.606487545873;5666.291713535808;5685.260916080924;5693.4875861172695;5698.8290351289525;5204.34945631796;5263.078961181778;5276.34045744282;5328.8401347959625;5329.680219186861;5771.192033115367;5826.737796799154;5827.067669172912;5830.416958304136;5856.824295271149;5619.8595035124445;5627.296587926509;5630.971845140748;5637.887242255132;5638.915416268759;5494.8076817312;5532.419095994943;5668.178114173422;5684.8294551163535;5692.601517893708;5675.801346952837;5701.657900525899;5708.80019199326;5711.771529138871;5712.485876271156;5657.8019769307875;5662.235598194191;5666.46168613981;5667.8866422672145;5669.886602267931;4435.556444355539;4436.489803672619;4446.510883802779;4451.087527056946;4480.193565158303;3886.0090676877217;3892.922141557153;3895.8831235062994;3946.8421263149726;3951.664108550748;5311.9734401328515;5359.571234301325;5399.865003374868;5406.729663516809;5449.5640348772795;5656.943430565641;5676;5678.432156784289;5680.5455563554815;5690.630109042899;5268.446813084647;5299.152135658276;5399.2980912481125;5400.054990376669;5463.535599474089;4933.506649335038;4967.90064198714;4980.452150263468;5037.924431133536;5064.848054558369;6024.487918526975;6024.819255422344;6025.216721826135;6036.396360363929;6040.697965101727;5548.4174161712435;5753.309602847685;5758.71206439668;5768.336641286138;5772;5828.504577110993;5917.142014407801;5941.049432090845;5952.494038006645;6064.06007068905;5593.105103183471;5642.746076426489;5643.238162848127;5643.971780141073;5646.802361917477;5694.430556944272;5752.194692742935;5761.625494342854;5763.106718458645;5764.942350576441;5444.8366549003595;5463.508284254436;5471.808486703106;5485.753141108739;5487.204355368529;5487.4238204987905;5499.285092937893;5508.3114610673665;5513.641613295123;5546.833594992157;5455.318085239345;5455.454454554671;5458.317710286215;5460.26286451324;5504.614676972574;5476.315460567429;5493.478119578634;5569.415211402907;5577.051901176891;5607.271054762855;5509.531689806411;5547.528460080938;5553.666779993213;5573.916391254053;5600.103983362643 15:43:18 INFO - PROCESS | 31829 | |1;ext.html;532.6024182533206;564.0439455123565;582.9038208695565;582.9183914252005;599.0893841361132;30036.549451758216;40954.79522602387;41761.58238417619;41868.16263674725;41908.58091419085;43722;44164.11671766563;44167.55832441683;44241.55758442415;44258.55741442584;7936.0873499547715;8523.105073967237;8678.088800675932;8679.132086791333;8680.652773889036;7799.064112306532;10067.546960386764;10312.948435257813;10320.483975801217;10652.41411722355;10394.532246048946;10468.633597824077;10469.73825654361;10475.633352832652;10476.947615261914;10368.222383321243;10439;10441.738956526071;10458.529366178464;10459.372437653727;10158.238132140119;10229.897701022968;10232.079112879877;10238.89761102387;10242.48787560619;40080;40457;40485.59514404848;40553.59446405528;40554.79722601368;3352.346292472969;3405.523226748257;3472.722182225416;3553.342631613134;3754.710720882693;29599.70400295991;31475.213119671964;32302;32363.19092022718;32455.51316730251;4129.8967525811795;4207.26372884744;4223.87328380146;4268.146370725867;4394.62645675118;330568;332036;332446;332596;333178;58915;59279;59453.70273148607;59698.403015969285;59780.70109649424;62429.37570624326;62431.68784156141;62457.375426245155;62541;62576.68711656413;14456.204908729911;14964.17697026674;14966.625834354229;14975.475858344906;14981.625459363386;10429.26995110335;10691.518881650345;11201.551937922555;11444.542218311175;11509.827352589718;18058.819411805714;18659.44021679352;18798.812011879705;18807.3417430392;19094.427167185007;6794.218664853506;7067.540609860343;7278.454115941326;7298.722723523362;7309.342159205697;947.2611363136764;966.1642679082543;1089.4334945828125;1104.6962085426412;1149.252985559393;32423.837880810446;32831.83584082064;32839;32916.50625240623;33157.33685326328;1048.3963216607222;1118.669992352258;1145.6963904565298;1166.719987203065;1173.096715529055;16740.581485462717;16880.57798555046;17010.659786804194;17120.14399280031;17388.826111738974;553521;555141;555318;555518;556955;56054;56507.43492565022;56632.71683641555;56658;56734.14898776521;1166.7491489329834;1186.291739894549;1268.1630124118037;1304.39345704248;1333.9466421343038;29145.7085429143;33095.834520827244;33169.66830331762;33254.83372583122;33546.66453335436;48475.75762121167;48891.26663100127;49128.75435622942;49150.5084949146;49172;354340;354968;357671;358554;359806;27421.31446713848;27757.306067348476;28166.71833281641;28250.2937426566;28589.428211436072;46090.769546152056;46357.53642463532;47574.76212618915;50544;50723;40324.1935161301;40528.3920741195;40834.183316332914;41474.58525414828;42295.36556951587;40784.79607601943;41689;41800.16399671929;42081.78959105307;42193.36709949292;40870.1825963485;41292;42339;42638.57361426346;42644;34329.65670343264;36964.873627993096;37033.62966370302;37216;37932.43101353427;27981.160565183076;28112.71887281101;28314.85842570774;28380.574291385234;28384.290392740346 15:43:18 INFO - PROCESS | 31829 | |2;jquery.html;382.79520456555747;393.48846499550575;406.3944722363678;413.24788884230696;423.7076417272082;13390.397432115566;15271.083734975895;18826.811731882677;18931.242750289974;19431.708524372112;18018.459446216602;18274.177662005208;18758.343457978972;19305.324313649024;19331.51671208217;4631.8842028949375;5528.612997090196;5741.1101279301565;5743.655380677152;5748.166515855199;4185.455890734201;4369.257226271526;5651.491365777079;5724.685142317171;6102.420270074358;6335.524835637322;6339.683015849212;6347.143135676693;6348.587341822767;6361;5444.809431669893;5715.2855893013375;5751.511121554673;5817.767289308465;6337.746490140389;5453.481919217668;5640.464155905223;5647.29408823897;5652.9152062719095;5654;13492.865071349357;13902.304884755722;13908.930455347658;13910.58268251944;13917.443302267897;2205.128974055255;2301.7813307735737;2586.1982785336604;2687.5296823055887;2901.3036871150985;10248.692539223835;10276.177905767521;10428.322159059713;10844.945775271073;10958.56165753369;1903.1530968718926;1951.2000079967145;1974;1974.6544354737864;1976.575036367188;79931.6003419985;84414.57792710997;84683;84795.5760221201;85048;10874.347539147677;10982.450877456255;11082.501287442085;11132.888671113347;11247.775044499063;15654.295556699975;15667.373305067898;15678.05931644105;15683.921580392025;15696.372145114296;7617.771466856003;7789.493682910593;7815.491993020435;8099.433039687283;8106.959465202636;7402.7409040683315;7406.111266647929;7445.8883116753295;7602.514516435219;7641.159472458025;4740.336352910595;4788.688735232199;4795.352627395257;4966.826161084345;4970.925436118461;1832.3220408448958;1844;1978.6644015289621;1988.33390814076;1998.7201791749167;884.3588398411229;916.9679061232958;1007.2546315726456;1029.4801125431609;1066.5147357952112;19799.60400791976;19977.500562486053;19988.600227995357;20111.49721256951;20231;984.227381505529;990.980180396388;992.5285489392625;1004.3622299839508;1007.5717819926502;10848.78302433947;11093.16801239894;11139.888601113886;11147.219694621299;11155.219134660496;464296;464903;473945;476087;495466;90551.54724226336;90942;91849;92524;92561;958.4919992404037;967.9661211857551;989.7129832348683;994.3636072913341;998.3311181508407;16552.83447165561;16871.072091035112;17026.574335641708;17613.471595852145;18011.90994045074;38832;39988.800055999534;42820.35769463398;43328.350074748276;43708.56291437045;58939;60044.699776500835;60760.08859867017;60778;61034.694826525585;8225;8393.916060839558;8641;8722.127787221227;8962.417442866194;11288.322700637988;12972.935135324264;13086.476540938636;13101.803472948104;13379.3979270935;11611.361375124448;11658.94170529142;11757.882421175678;11850.644480665595;12273.631791046282;10629;11228.550857965916;11264.718382040186;11303.321800691985;11307.265027773168;10881.564737410416;11233.438328083399;11275.66173014811;11776.70558236051;11822.881771182178;8583.570821458778;8619.138086191331;8665.17680820321;8805.16350946659;8810.867836982323;10112.848307275544;11175.832362514731;11198.608048718255;11211.215214934877;11818.40907954616 15:43:18 INFO - PROCESS | 31829 | |3;mootools.html;1411.0686946615235;1461.021115852379;1536.4161618584935;1682.4952514245724;1712.7773389459376;7173.318534739192;7389.630518474069;7849.489783164097;8133.552654603995;8137.226963438464;7728.188540203282;7980.244346243831;7985.1216366199815;7987.440879138463;7993.640286187121;2271.1029143488313;2272.8295377846644;2278.829087818412;2294.0823670531836;2310.3069079276233;2031.289048832904;2092.225876425717;2294.6443301288327;2314.2363020203293;2373.193114341124;2250.3923940536047;2297.7012988311494;2305.7924786769186;2320.779525945041;2334.8482348647285;2293.2203050962753;2295.621222498286;2314.247869442438;2318.466752646884;2329.848559843622;2328.0571368595747;2334.7198336199594;2343.3907184132077;2354.0348457132495;2382.0948039744785;8017.518948863087;8183.918160818375;8190.099089100254;8193.344532437392;8196.754097377028;4827.131116399047;4988.102141614508;4988.87527811804;4993.201087825967;4997.250412438127;3137.98567029725;3357.0600231935096;3434.553508043963;3455.291665208626;3464.532288141094;1007.3099926550263;1083.4745148602922;1092.9180311476591;1097.7310558913118;1115.9218854680175;11321.150913681508;11323.263987840846;11342.149338799623;11359.943200283946;11375.715607109805;4238.449001629769;4426.667999900021;4523.25366314561;4544.681872268976;4547.590716835501;9239.72280831576;9285.814283714288;9337;9343.813123737487;9355;4953.083679519301;4957.281194226817;4963.875903102451;4980.576650984707;4982.177940639754;4475.239209334421;4550.544945505423;4614.1694494991225;4622.237330840374;4622.2835460503675;3632.8365223565;3661.8718344857803;3722.0694826293425;3748.2878253131817;3771.07608635886;1102.388174563109;1109.8446217529552;1185.8399116119385;1200.4537935239446;1214.769193853165;804.6097642643314;945.7730144765344;965.4159233663673;985.3102828020415;987.8483707465601;5566.805161819398;5691.174779656926;5693.572982026365;5889.852753681193;5937.079752638348;888.5068786823246;893.4371346052076;905.968291109808;913.2693844924167;933.9346245762868;3764.3976963685677;3913.412988051815;3925.097227637659;3945.9802700986884;3962.5641179470235;9882.357646752938;10166.135878450266;10171.694849154537;10172.949135254275;10184.338018028804;9507.096825801538;10074.44590547527;10103;10105.14106300958;10113.241506887012;7329.74345897891;7718.92281077182;7730.033745781778;7730.951297906059;7735.845283094307;5329.360476742816;5444.646098003617;5546.112621980464;5689.089745640677;5756.453136951983;8986.101389860962;9071.954640226757;9109.134632209929;9149.954250228706;9202.401843880127;9094.317926155432;9142.771430714285;9268.58291376903;9395.107464790834;9508.619655213713;7061.682224299816;7347.26527347261;7506.849863002819;7509.1739908608915;7510.098788145458;7802.102758182881;7987.081485629227;8024.759257222293;8043.718469853527;8044.517328960281;7052.858942821217;7175.892361614684;7222.133343998754;7242.239564845615;7386.113666359856;6870.690818913261;6925.58446493212;7025.929740702528;7118.145822501333;7134.429245660439;6556.475481961527;6653.667316634052;6709.329067093252;6711.832204194934;6727.125473688585;4821.662483626113;4846.660733748604;4895.8041678332465;4897.363342765418;4956.702597844141;4579.198640237879;4590.265557510916;4640.9535904640525;4730.834420795256;4879 15:43:18 INFO - PROCESS | 31829 | |4;prototype.html;331.2100639973662;341.2407393549353;348.99476507852387;350.0757998882948;351.0556602738631;5041.596672266219;5091.24689101315;5132.743362831858;5216.686998780076;5221.425643179247;5031.547160755531;5073.188289873621;5081.593472522199;5106.374474123377;5149.356330458692;4095.9795201024026;4117.155983023473;4118.6499147572495;4125.401816736571;4153.563875793028;4051.2932402411943;4097.836086556535;4160.563140870196;4166.166766646667;4168.62482376586;4075.6331930126285;4078.796060196993;4080.571539988303;4100.2414553307735;4119.773412462313;4063.7155399122075;4073.959260407388;4080.306347920846;4094.5905409459115;4108.322126849066;3682.6685598296012;3690.7785532867847;3693.575238847513;3697.7226707997006;3702.389105797567;4860.343853579757;4983.975080124576;5063.696178229318;5071.46749591295;5080.390353157644;4711.042724111762;4714.457837348715;4720.693154944917;4737.95262047382;4751.928721069186;5436.293281873371;5444.700541470217;5451.209574611659;5451.291332126798;5474.753636086346;3904.3016287914566;4024.63778259958;4048.736832105904;4059.7564146151326;4071.3485842265095;5588.6646801191655;5589.469000444951;5620.241267428885;5626.493615574577;5630.859228519279;4141.503019637603;4144.958550414518;4153.979230103831;4160.583941605815;4165.083681590046;4079.592040795956;4158.542560318362;4190.895227619273;4196.748195108304;4206.49522057349;4664.79008444614;4687.367205427224;4689.132510485571;4701.64737644678;4727.432708075053;5397.946020539823;5426.8914621707345;5435.972820135874;5477.75350109246;5486.533644640251;1300.8829205371562;1332.8933685305153;1406.5709958462767;1406.8944829137856;1416.2423103639503;934.6541779541477;970.1753509516855;977.9168770654431;978.9916386122305;983.8819341679044;5104.591632669378;5160.690358578498;5167.793288268427;5172.508611681884;5182.807954170562;5351.9296140772;5378.865528361822;5387.138057910715;5403.324584426947;5403.432639572867;4904.975475122673;5148.150555158357;5162.66442681232;5165.431802501722;5165.50927661879;2821.971780282212;2836.744692977642;2847.2454799478155;2847.487452258572;2865.20642373684;5571.4150014248735;5581.665100094007;5603.6077474577205;5614.803481878196;5664.6034777566;5329.25390445338;5494.313210848644;5497.917531237034;5531.668099913937;5532.585056120807;5628.915566266509;5633.324001119892;5644.3508996465935;5671.85212207229;5690.292912126346;5177.663451875616;5297;5350.411454740053;5351.224072509386;5354.7858085676135;5252.2646829444675;5270.209468579744;5324.8136315228785;5328.467153284795;5348.491893270133;5614.2701448811395;5622.762992141722;5636.239107720569;5648.689322087324;5660.773569057192;3924.9215015700097;3974.364101743707;4029.730634850013;4034.374671925856;4034.556198818186;5307.65500242483;5330.760115794876;5331.027519817692;5346.984073026113;5406.513413792777;5271.759502211468;5313.309269794902;5418.106012507892;5426.918596221139;5441.809536666197;5422.403535611001;5438.700871452108;5474.534664553557;5480.738960318604;5490.313710786152;5247.536625826936;5343.251944727664;5417.945820541744;5429.185622156708;5445.428230035947;5501.504864562208;5514.862128446821;5522.972385138049;5530.253415788978;5542.251796007487;5429.321334833146;5429.511343979061;5436.755346009518;5440.319960004999;5448.5368743655645 15:43:18 INFO - PROCESS | 31829 | |5;yui.html;705.9244035385577;713.464901324007;741.2513361504879;750.6659536506254;775.352580595203;13354.26551539665;14224.431022759103;14231.430742770277;14266.57200283992;14326.570202893903;13874.375653095609;14016.789748153786;14144.222067786268;14153.433862645508;14178;652.7421668440963;673.6093066021696;746.902902622661;770.6686124966262;775.1008829757483;774.5507605588773;782.8277778888636;783.9843203135933;784.2627929746048;785.3913217256614;833.5540485840077;834.0575150080431;834.4200780457585;834.5326617094447;834.9749507514784;682.4028974647184;698.3016983016983;795.8607243732324;826.5123577089516;827.028241815867;604.2477115990575;604.3684349854412;606.429955841512;607.8358843112379;608.9056196289538;13673.453061877513;13699;13739.450421983109;13755.31223438824;13765.242911639856;13376.464941402332;13748.243846588433;14290.214038227894;14389.474578728174;14709.117452952856;12757.55348562796;12826;12833.67915802103;13210.66973325665;13288.402021909038;4149.398337241083;4232.936505952413;4297;4302.956970430287;4434.24617814969;88461.55769221178;91241.54379228127;92356.29942909721;92362.76372362777;92468;10878.564857405774;10973.780524389467;11231.887681123248;11437.656870293904;11498.367589782474;20621.58756824855;21478.355649330544;21661.67507487389;21667.133314667553;21673.133074677153;7720.613969301512;7796.922030779733;7847.372210223169;7850.842983140419;8016.839663206703;4243.321068629005;4272.914541709149;4381.539938306496;4409.713368631029;4451.554844515587;3174.841257937094;3359.6136444308727;3363.983180084133;3406.6593340665736;3412.1640198151613;609.5641616244407;610.1275176497562;614.3825455417366;615.0865964043392;650.677914432359;638.4828289085856;724.1418918581497;725.8475720098733;737.1412304665113;762.4510352546158;9718.70843874685;9899.406035637885;10660.307080039927;10839.458027098613;10958.397288149068;612.3233826621608;668.3283300283282;714.2821464428216;716.9390601798801;727.6907314391362;4719.5752382285755;4887.706737595756;4913.263010548375;4957.355543779286;4987.675801072991;84495.577522112;87064;87507.1249287499;87752.56123719341;88052;66847.66576167186;78449;78483;80531.59734201408;82925;71052;71725.28274717186;71729.64135179395;71964.64017679878;72248.63875680589;9354.672586459441;9536.141747242782;9603.9039609603;9618.470984095662;9690.273229507957;48141.518584813704;48387.27419088787;48932.75533622309;49047.26429103638;50190;63153.68423157855;66171.72853393326;66187.33812661812;66653;68711.3128868705;11819.0544756421;12083.879161208275;12140.939295303468;12161.270323780602;12267;13598.388072536958;13604.727905442034;14287.499937502138;14552;14811.111333320036;12970.935145324212;13837.79243311331;13846.307684615931;13933;14318;12896.231646575216;13382.397792099573;13422.127561708458;13614.727705445637;13734.793978090536;12195.756084878076;12578.937105314415;12842.422091006114;12967.22196668203;13241.668958276121;10847.728806779895;10923.344599324066;11284.830727538929;11338;11677.591284305008;9803.80392392134;10868.728281793019;11098.724142202404;11229.606963756229;11439.59961401347 15:43:18 INFO - PROCESS | 31829 | __end_tp_report 15:43:18 INFO - PROCESS | 31829 | __start_cc_report 15:43:18 INFO - PROCESS | 31829 | _x_x_mozilla_cycle_collect,1457 15:43:18 INFO - PROCESS | 31829 | __end_cc_report 15:43:18 INFO - PROCESS | 31829 | __startTimestamp1480203798308__endTimestamp 15:43:18 INFO - PROCESS | 31829 | 15:43:18 INFO - PROCESS | 31829 | ------- Summary: start ------- 15:43:18 INFO - PROCESS | 31829 | Number of tests: 6 15:43:18 INFO - PROCESS | 31829 | 15:43:18 INFO - PROCESS | 31829 | [#0] dojo.html Cycles:165 Average:5296.29 Median:5476.32 stddev:588.48 (10.7%) stddev-sans-first:564.07 15:43:18 INFO - PROCESS | 31829 | Values: 3082.2 3109.5 3111.1 3137.6 3154.3 5231.9 5317.3 5319.3 5361.6 5367.0 5250.1 5289.8 5304.4 5326.1 5383.1 4799.6 4834.9 4835.4 4853.7 4871.0 4823.8 4935.3 4936.9 4941.9 4976.4 4910.2 4952.7 4961.8 4966.9 5011.1 4744.7 4788.4 4790.8 4801.5 4887.3 4801.1 4803.3 4812.2 4812.4 4819.2 5156.3 5190.7 5250.1 5302.4 5316.9 5643.4 5646.8 5650.9 5652.0 5657.1 5621.6 5666.3 5685.3 5693.5 5698.8 5204.3 5263.1 5276.3 5328.8 5329.7 5771.2 5826.7 5827.1 5830.4 5856.8 5619.9 5627.3 5631.0 5637.9 5638.9 5494.8 5532.4 5668.2 5684.8 5692.6 5675.8 5701.7 5708.8 5711.8 5712.5 5657.8 5662.2 5666.5 5667.9 5669.9 4435.6 4436.5 4446.5 4451.1 4480.2 3886.0 3892.9 3895.9 3946.8 3951.7 5312.0 5359.6 5399.9 5406.7 5449.6 5656.9 5676.0 5678.4 5680.5 5690.6 5268.4 5299.2 5399.3 5400.1 5463.5 4933.5 4967.9 4980.5 5037.9 5064.8 6024.5 6024.8 6025.2 6036.4 6040.7 5548.4 5753.3 5758.7 5768.3 5772.0 5828.5 5917.1 5941.0 5952.5 6064.1 5593.1 5642.7 5643.2 5644.0 5646.8 5694.4 5752.2 5761.6 5763.1 5764.9 5444.8 5463.5 5471.8 5485.8 5487.2 5487.4 5499.3 5508.3 5513.6 5546.8 5455.3 5455.5 5458.3 5460.3 5504.6 5476.3 5493.5 5569.4 5577.1 5607.3 5509.5 5547.5 5553.7 5573.9 5600.1 15:43:18 INFO - PROCESS | 31829 | 15:43:18 INFO - PROCESS | 31829 | [#1] ext.html Cycles:180 Average:58017.86 Median:358112.50 stddev:113148.43 (31.6%) stddev-sans-first:113383.52 15:43:18 INFO - PROCESS | 31829 | Values: 532.6 564.0 582.9 582.9 599.1 30036.5 40954.8 41761.6 41868.2 41908.6 43722.0 44164.1 44167.6 44241.6 44258.6 7936.1 8523.1 8678.1 8679.1 8680.7 7799.1 10067.5 10312.9 10320.5 10652.4 10394.5 10468.6 10469.7 10475.6 10476.9 10368.2 10439.0 10441.7 10458.5 10459.4 10158.2 10229.9 10232.1 10238.9 10242.5 40080.0 40457.0 40485.6 40553.6 40554.8 3352.3 3405.5 3472.7 3553.3 3754.7 29599.7 31475.2 32302.0 32363.2 32455.5 4129.9 4207.3 4223.9 4268.1 4394.6 330568.0 332036.0 332446.0 332596.0 333178.0 58915.0 59279.0 59453.7 59698.4 59780.7 62429.4 62431.7 62457.4 62541.0 62576.7 14456.2 14964.2 14966.6 14975.5 14981.6 10429.3 10691.5 11201.6 11444.5 11509.8 18058.8 18659.4 18798.8 18807.3 19094.4 6794.2 7067.5 7278.5 7298.7 7309.3 947.3 966.2 1089.4 1104.7 1149.3 32423.8 32831.8 32839.0 32916.5 33157.3 1048.4 1118.7 1145.7 1166.7 1173.1 16740.6 16880.6 17010.7 17120.1 17388.8 553521.0 555141.0 555318.0 555518.0 556955.0 56054.0 56507.4 56632.7 56658.0 56734.1 1166.7 1186.3 1268.2 1304.4 1333.9 29145.7 33095.8 33169.7 33254.8 33546.7 48475.8 48891.3 49128.8 49150.5 49172.0 354340.0 354968.0 357671.0 358554.0 359806.0 27421.3 27757.3 28166.7 28250.3 28589.4 46090.8 46357.5 47574.8 50544.0 50723.0 40324.2 40528.4 40834.2 41474.6 42295.4 40784.8 41689.0 41800.2 42081.8 42193.4 40870.2 41292.0 42339.0 42638.6 42644.0 34329.7 36964.9 37033.6 37216.0 37932.4 27981.2 28112.7 28314.9 28380.6 28384.3 15:43:18 INFO - PROCESS | 31829 | 15:43:18 INFO - PROCESS | 31829 | [#2] jquery.html Cycles:180 Average:28383.10 Median:19607.40 stddev:78534.51 (400.5%) stddev-sans-first:78726.67 15:43:18 INFO - PROCESS | 31829 | Values: 382.8 393.5 406.4 413.2 423.7 13390.4 15271.1 18826.8 18931.2 19431.7 18018.5 18274.2 18758.3 19305.3 19331.5 4631.9 5528.6 5741.1 5743.7 5748.2 4185.5 4369.3 5651.5 5724.7 6102.4 6335.5 6339.7 6347.1 6348.6 6361.0 5444.8 5715.3 5751.5 5817.8 6337.7 5453.5 5640.5 5647.3 5652.9 5654.0 13492.9 13902.3 13908.9 13910.6 13917.4 2205.1 2301.8 2586.2 2687.5 2901.3 10248.7 10276.2 10428.3 10844.9 10958.6 1903.2 1951.2 1974.0 1974.7 1976.6 79931.6 84414.6 84683.0 84795.6 85048.0 10874.3 10982.5 11082.5 11132.9 11247.8 15654.3 15667.4 15678.1 15683.9 15696.4 7617.8 7789.5 7815.5 8099.4 8107.0 7402.7 7406.1 7445.9 7602.5 7641.2 4740.3 4788.7 4795.4 4966.8 4970.9 1832.3 1844.0 1978.7 1988.3 1998.7 884.4 917.0 1007.3 1029.5 1066.5 19799.6 19977.5 19988.6 20111.5 20231.0 984.2 991.0 992.5 1004.4 1007.6 10848.8 11093.2 11139.9 11147.2 11155.2 464296.0 464903.0 473945.0 476087.0 495466.0 90551.5 90942.0 91849.0 92524.0 92561.0 958.5 968.0 989.7 994.4 998.3 16552.8 16871.1 17026.6 17613.5 18011.9 38832.0 39988.8 42820.4 43328.4 43708.6 58939.0 60044.7 60760.1 60778.0 61034.7 8225.0 8393.9 8641.0 8722.1 8962.4 11288.3 12972.9 13086.5 13101.8 13379.4 11611.4 11658.9 11757.9 11850.6 12273.6 10629.0 11228.6 11264.7 11303.3 11307.3 10881.6 11233.4 11275.7 11776.7 11822.9 8583.6 8619.1 8665.2 8805.2 8810.9 10112.8 11175.8 11198.6 11211.2 11818.4 15:43:18 INFO - PROCESS | 31829 | 15:43:18 INFO - PROCESS | 31829 | [#3] mootools.html Cycles:180 Average:5411.55 Median:4960.58 stddev:2978.75 (60.0%) stddev-sans-first:2971.93 15:43:18 INFO - PROCESS | 31829 | Values: 1411.1 1461.0 1536.4 1682.5 1712.8 7173.3 7389.6 7849.5 8133.6 8137.2 7728.2 7980.2 7985.1 7987.4 7993.6 2271.1 2272.8 2278.8 2294.1 2310.3 2031.3 2092.2 2294.6 2314.2 2373.2 2250.4 2297.7 2305.8 2320.8 2334.8 2293.2 2295.6 2314.2 2318.5 2329.8 2328.1 2334.7 2343.4 2354.0 2382.1 8017.5 8183.9 8190.1 8193.3 8196.8 4827.1 4988.1 4988.9 4993.2 4997.3 3138.0 3357.1 3434.6 3455.3 3464.5 1007.3 1083.5 1092.9 1097.7 1115.9 11321.2 11323.3 11342.1 11359.9 11375.7 4238.4 4426.7 4523.3 4544.7 4547.6 9239.7 9285.8 9337.0 9343.8 9355.0 4953.1 4957.3 4963.9 4980.6 4982.2 4475.2 4550.5 4614.2 4622.2 4622.3 3632.8 3661.9 3722.1 3748.3 3771.1 1102.4 1109.8 1185.8 1200.5 1214.8 804.6 945.8 965.4 985.3 987.8 5566.8 5691.2 5693.6 5889.9 5937.1 888.5 893.4 906.0 913.3 933.9 3764.4 3913.4 3925.1 3946.0 3962.6 9882.4 10166.1 10171.7 10172.9 10184.3 9507.1 10074.4 10103.0 10105.1 10113.2 7329.7 7718.9 7730.0 7731.0 7735.8 5329.4 5444.6 5546.1 5689.1 5756.5 8986.1 9072.0 9109.1 9150.0 9202.4 9094.3 9142.8 9268.6 9395.1 9508.6 7061.7 7347.3 7506.8 7509.2 7510.1 7802.1 7987.1 8024.8 8043.7 8044.5 7052.9 7175.9 7222.1 7242.2 7386.1 6870.7 6925.6 7025.9 7118.1 7134.4 6556.5 6653.7 6709.3 6711.8 6727.1 4821.7 4846.7 4895.8 4897.4 4956.7 4579.2 4590.3 4641.0 4730.8 4879.0 15:43:18 INFO - PROCESS | 31829 | 15:43:18 INFO - PROCESS | 31829 | [#4] prototype.html Cycles:180 Average:4564.30 Median:5170.15 stddev:1306.21 (25.3%) stddev-sans-first:1270.65 15:43:18 INFO - PROCESS | 31829 | Values: 331.2 341.2 349.0 350.1 351.1 5041.6 5091.2 5132.7 5216.7 5221.4 5031.5 5073.2 5081.6 5106.4 5149.4 4096.0 4117.2 4118.6 4125.4 4153.6 4051.3 4097.8 4160.6 4166.2 4168.6 4075.6 4078.8 4080.6 4100.2 4119.8 4063.7 4074.0 4080.3 4094.6 4108.3 3682.7 3690.8 3693.6 3697.7 3702.4 4860.3 4984.0 5063.7 5071.5 5080.4 4711.0 4714.5 4720.7 4738.0 4751.9 5436.3 5444.7 5451.2 5451.3 5474.8 3904.3 4024.6 4048.7 4059.8 4071.3 5588.7 5589.5 5620.2 5626.5 5630.9 4141.5 4145.0 4154.0 4160.6 4165.1 4079.6 4158.5 4190.9 4196.7 4206.5 4664.8 4687.4 4689.1 4701.6 4727.4 5397.9 5426.9 5436.0 5477.8 5486.5 1300.9 1332.9 1406.6 1406.9 1416.2 934.7 970.2 977.9 979.0 983.9 5104.6 5160.7 5167.8 5172.5 5182.8 5351.9 5378.9 5387.1 5403.3 5403.4 4905.0 5148.2 5162.7 5165.4 5165.5 2822.0 2836.7 2847.2 2847.5 2865.2 5571.4 5581.7 5603.6 5614.8 5664.6 5329.3 5494.3 5497.9 5531.7 5532.6 5628.9 5633.3 5644.4 5671.9 5690.3 5177.7 5297.0 5350.4 5351.2 5354.8 5252.3 5270.2 5324.8 5328.5 5348.5 5614.3 5622.8 5636.2 5648.7 5660.8 3924.9 3974.4 4029.7 4034.4 4034.6 5307.7 5330.8 5331.0 5347.0 5406.5 5271.8 5313.3 5418.1 5426.9 5441.8 5422.4 5438.7 5474.5 5480.7 5490.3 5247.5 5343.3 5417.9 5429.2 5445.4 5501.5 5514.9 5523.0 5530.3 5542.3 5429.3 5429.5 5436.8 5440.3 5448.5 15:43:18 INFO - PROCESS | 31829 | 15:43:18 INFO - PROCESS | 31829 | [#5] yui.html Cycles:180 Average:18992.87 Median:26910.23 stddev:25831.23 (96.0%) stddev-sans-first:25867.20 15:43:18 INFO - PROCESS | 31829 | Values: 705.9 713.5 741.3 750.7 775.4 13354.3 14224.4 14231.4 14266.6 14326.6 13874.4 14016.8 14144.2 14153.4 14178.0 652.7 673.6 746.9 770.7 775.1 774.6 782.8 784.0 784.3 785.4 833.6 834.1 834.4 834.5 835.0 682.4 698.3 795.9 826.5 827.0 604.2 604.4 606.4 607.8 608.9 13673.5 13699.0 13739.5 13755.3 13765.2 13376.5 13748.2 14290.2 14389.5 14709.1 12757.6 12826.0 12833.7 13210.7 13288.4 4149.4 4232.9 4297.0 4303.0 4434.2 88461.6 91241.5 92356.3 92362.8 92468.0 10878.6 10973.8 11231.9 11437.7 11498.4 20621.6 21478.4 21661.7 21667.1 21673.1 7720.6 7796.9 7847.4 7850.8 8016.8 4243.3 4272.9 4381.5 4409.7 4451.6 3174.8 3359.6 3364.0 3406.7 3412.2 609.6 610.1 614.4 615.1 650.7 638.5 724.1 725.8 737.1 762.5 9718.7 9899.4 10660.3 10839.5 10958.4 612.3 668.3 714.3 716.9 727.7 4719.6 4887.7 4913.3 4957.4 4987.7 84495.6 87064.0 87507.1 87752.6 88052.0 66847.7 78449.0 78483.0 80531.6 82925.0 71052.0 71725.3 71729.6 71964.6 72248.6 9354.7 9536.1 9603.9 9618.5 9690.3 48141.5 48387.3 48932.8 49047.3 50190.0 63153.7 66171.7 66187.3 66653.0 68711.3 11819.1 12083.9 12140.9 12161.3 12267.0 13598.4 13604.7 14287.5 14552.0 14811.1 12970.9 13837.8 13846.3 13933.0 14318.0 12896.2 13382.4 13422.1 13614.7 13734.8 12195.8 12578.9 12842.4 12967.2 13241.7 10847.7 10923.3 11284.8 11338.0 11677.6 9803.8 10868.7 11098.7 11229.6 11439.6 15:43:18 INFO - PROCESS | 31829 | -------- Summary: end -------- 15:43:18 INFO - PROCESS | 31829 | 15:43:19 INFO - TEST-INFO | 31829: exit 0 15:43:19 INFO - TEST-OK | dromaeo_css | took 1118619ms 15:43:19 INFO - TEST-START | kraken 15:43:19 INFO - operating with platform_type : linux_ 15:43:19 INFO - Initialising browser for kraken test... 15:43:19 INFO - TEST-INFO | started process 32135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW71OGB/profile http://localhost:53923/getInfo.html) 15:43:23 INFO - PROCESS | 32135 | __metrics Screen width/height:1600/1200 15:43:23 INFO - PROCESS | 32135 | colorDepth:24 15:43:23 INFO - PROCESS | 32135 | Browser inner width/height: 1024/697 15:43:23 INFO - PROCESS | 32135 | __metrics 15:43:23 INFO - PROCESS | 32135 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:43:23 INFO - PROCESS | 32135 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:43:24 INFO - PROCESS | 32135 | console.error: PushService: 15:43:24 INFO - PROCESS | 32135 | stateChangeProcessEnqueue: Error transitioning state 15:43:24 INFO - PROCESS | 32135 | UnknownError 15:43:25 INFO - TEST-INFO | 32135: exit 0 15:43:25 INFO - Browser initialized. 15:43:25 INFO - Running cycle 1/1 for kraken test... 15:43:25 INFO - TEST-INFO | started process 32220 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW71OGB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:43:37 INFO - PROCESS | 32220 | RSS: Main: 172994560 15:43:37 INFO - PROCESS | 32220 | 15:43:39 INFO - PROCESS | 32220 | Cycle 1(1): loaded http://localhost:53923/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53923/tests/kraken/driver.html?testName=audio-beat-detection) 15:43:40 INFO - PROCESS | 32220 | RSS: Main: 238989312 15:43:40 INFO - PROCESS | 32220 | 15:43:43 INFO - PROCESS | 32220 | Cycle 1(1): loaded http://localhost:53923/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53923/tests/kraken/driver.html?testName=audio-dft) 15:43:43 INFO - PROCESS | 32220 | RSS: Main: 217260032 15:43:43 INFO - PROCESS | 32220 | 15:43:46 INFO - PROCESS | 32220 | Cycle 1(1): loaded http://localhost:53923/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53923/tests/kraken/driver.html?testName=audio-fft) 15:43:47 INFO - PROCESS | 32220 | RSS: Main: 298020864 15:43:47 INFO - PROCESS | 32220 | 15:43:49 INFO - PROCESS | 32220 | Cycle 1(1): loaded http://localhost:53923/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53923/tests/kraken/driver.html?testName=audio-oscillator) 15:43:50 INFO - PROCESS | 32220 | RSS: Main: 209944576 15:43:50 INFO - PROCESS | 32220 | 15:43:52 INFO - PROCESS | 32220 | Cycle 1(1): loaded http://localhost:53923/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53923/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:43:52 INFO - PROCESS | 32220 | RSS: Main: 213864448 15:43:52 INFO - PROCESS | 32220 | 15:43:55 INFO - PROCESS | 32220 | Cycle 1(1): loaded http://localhost:53923/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53923/tests/kraken/driver.html?testName=imaging-darkroom) 15:43:56 INFO - PROCESS | 32220 | RSS: Main: 252477440 15:43:56 INFO - PROCESS | 32220 | 15:43:59 INFO - PROCESS | 32220 | Cycle 1(1): loaded http://localhost:53923/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53923/tests/kraken/driver.html?testName=imaging-desaturate) 15:44:00 INFO - PROCESS | 32220 | RSS: Main: 252174336 15:44:00 INFO - PROCESS | 32220 | 15:44:03 INFO - PROCESS | 32220 | Cycle 1(1): loaded http://localhost:53923/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53923/tests/kraken/driver.html?testName=json-parse-financial) 15:44:03 INFO - PROCESS | 32220 | RSS: Main: 251420672 15:44:03 INFO - PROCESS | 32220 | 15:44:05 INFO - PROCESS | 32220 | Cycle 1(1): loaded http://localhost:53923/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53923/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:44:05 INFO - PROCESS | 32220 | RSS: Main: 213381120 15:44:05 INFO - PROCESS | 32220 | 15:44:07 INFO - PROCESS | 32220 | Cycle 1(1): loaded http://localhost:53923/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53923/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:44:08 INFO - PROCESS | 32220 | RSS: Main: 220655616 15:44:08 INFO - PROCESS | 32220 | 15:44:10 INFO - PROCESS | 32220 | Cycle 1(1): loaded http://localhost:53923/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53923/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:44:10 INFO - PROCESS | 32220 | RSS: Main: 229638144 15:44:10 INFO - PROCESS | 32220 | 15:44:13 INFO - PROCESS | 32220 | Cycle 1(1): loaded http://localhost:53923/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53923/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:44:14 INFO - PROCESS | 32220 | RSS: Main: 239001600 15:44:14 INFO - PROCESS | 32220 | 15:44:17 INFO - PROCESS | 32220 | Cycle 1(1): loaded http://localhost:53923/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53923/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:44:17 INFO - PROCESS | 32220 | RSS: Main: 235573248 15:44:17 INFO - PROCESS | 32220 | 15:44:19 INFO - PROCESS | 32220 | Cycle 1(1): loaded http://localhost:53923/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53923/tests/kraken/driver.html?testName=ai-astar) 15:44:19 INFO - PROCESS | 32220 | RSS: Main: 286912512 15:44:19 INFO - PROCESS | 32220 | 15:44:19 INFO - PROCESS | 32220 | __start_tp_report 15:44:19 INFO - PROCESS | 32220 | _x_x_mozilla_page_load 15:44:19 INFO - PROCESS | 32220 | _x_x_mozilla_page_load_details 15:44:19 INFO - PROCESS | 32220 | |i|pagename|runs| 15:44:19 INFO - PROCESS | 32220 | |0;ai-astar;106;113;112;111;112;113;112;111;112;111 15:44:19 INFO - PROCESS | 32220 | |1;audio-beat-detection;149;131;124;162;122;133;123;122;152;126 15:44:19 INFO - PROCESS | 32220 | |2;audio-dft;162;162;162;165;164;161;162;162;161;160 15:44:19 INFO - PROCESS | 32220 | |3;audio-fft;85;75;76;103;78;77;76;76;96;77 15:44:19 INFO - PROCESS | 32220 | |4;audio-oscillator;82;83;111;83;81;81;102;83;82;115 15:44:19 INFO - PROCESS | 32220 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;117;117;116 15:44:19 INFO - PROCESS | 32220 | |6;imaging-darkroom;146;146;146;145;146;147;145;146;147;146 15:44:19 INFO - PROCESS | 32220 | |7;imaging-desaturate;95;95;96;95;95;95;96;95;96;96 15:44:19 INFO - PROCESS | 32220 | |8;json-parse-financial;52;52;53;52;54;52;51;53;51;52 15:44:19 INFO - PROCESS | 32220 | |9;json-stringify-tinderbox;62;62;62;62;62;62;61;62;62;62 15:44:19 INFO - PROCESS | 32220 | |10;stanford-crypto-aes;88;80;87;80;81;88;81;82;81;81 15:44:19 INFO - PROCESS | 32220 | |11;stanford-crypto-ccm;142;147;132;138;137;131;132;132;177;130 15:44:19 INFO - PROCESS | 32220 | |12;stanford-crypto-pbkdf2;167;162;163;164;165;180;162;169;163;173 15:44:19 INFO - PROCESS | 32220 | |13;stanford-crypto-sha256-iterative;71;67;66;67;65;65;66;65;70;65 15:44:19 INFO - PROCESS | 32220 | __end_tp_report 15:44:19 INFO - PROCESS | 32220 | __start_cc_report 15:44:19 INFO - PROCESS | 32220 | _x_x_mozilla_cycle_collect,1673 15:44:19 INFO - PROCESS | 32220 | __end_cc_report 15:44:19 INFO - PROCESS | 32220 | __startTimestamp1480203859701__endTimestamp 15:44:19 INFO - PROCESS | 32220 | 15:44:19 INFO - PROCESS | 32220 | ------- Summary: start ------- 15:44:19 INFO - PROCESS | 32220 | Number of tests: 14 15:44:19 INFO - PROCESS | 32220 | 15:44:19 INFO - PROCESS | 32220 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.00 (1.8%) stddev-sans-first:0.78 15:44:19 INFO - PROCESS | 32220 | Values: 106.0 113.0 112.0 111.0 112.0 113.0 112.0 111.0 112.0 111.0 15:44:19 INFO - PROCESS | 32220 | 15:44:19 INFO - PROCESS | 32220 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:132.00 stddev:14.58 (11.0%) stddev-sans-first:14.48 15:44:19 INFO - PROCESS | 32220 | Values: 149.0 131.0 124.0 162.0 122.0 133.0 123.0 122.0 152.0 126.0 15:44:19 INFO - PROCESS | 32220 | 15:44:19 INFO - PROCESS | 32220 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.45 (0.9%) stddev-sans-first:1.54 15:44:19 INFO - PROCESS | 32220 | Values: 162.0 162.0 162.0 165.0 164.0 161.0 162.0 162.0 161.0 160.0 15:44:19 INFO - PROCESS | 32220 | 15:44:19 INFO - PROCESS | 32220 | [#3] audio-fft Cycles:10 Average:81.90 Median:77.00 stddev:9.83 (12.8%) stddev-sans-first:10.36 15:44:19 INFO - PROCESS | 32220 | Values: 85.0 75.0 76.0 103.0 78.0 77.0 76.0 76.0 96.0 77.0 15:44:19 INFO - PROCESS | 32220 | 15:44:19 INFO - PROCESS | 32220 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:82.00 stddev:13.52 (16.5%) stddev-sans-first:14.01 15:44:19 INFO - PROCESS | 32220 | Values: 82.0 83.0 111.0 83.0 81.0 81.0 102.0 83.0 82.0 115.0 15:44:19 INFO - PROCESS | 32220 | 15:44:19 INFO - PROCESS | 32220 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 15:44:19 INFO - PROCESS | 32220 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 15:44:19 INFO - PROCESS | 32220 | 15:44:19 INFO - PROCESS | 32220 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 15:44:19 INFO - PROCESS | 32220 | Values: 146.0 146.0 146.0 145.0 146.0 147.0 145.0 146.0 147.0 146.0 15:44:19 INFO - PROCESS | 32220 | 15:44:19 INFO - PROCESS | 32220 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 15:44:19 INFO - PROCESS | 32220 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 15:44:19 INFO - PROCESS | 32220 | 15:44:19 INFO - PROCESS | 32220 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.00 stddev:0.92 (1.8%) stddev-sans-first:0.97 15:44:19 INFO - PROCESS | 32220 | Values: 52.0 52.0 53.0 52.0 54.0 52.0 51.0 53.0 51.0 52.0 15:44:19 INFO - PROCESS | 32220 | 15:44:19 INFO - PROCESS | 32220 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 15:44:19 INFO - PROCESS | 32220 | Values: 62.0 62.0 62.0 62.0 62.0 62.0 61.0 62.0 62.0 62.0 15:44:19 INFO - PROCESS | 32220 | 15:44:19 INFO - PROCESS | 32220 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:81.50 stddev:3.35 (4.1%) stddev-sans-first:3.00 15:44:19 INFO - PROCESS | 32220 | Values: 88.0 80.0 87.0 80.0 81.0 88.0 81.0 82.0 81.0 81.0 15:44:19 INFO - PROCESS | 32220 | 15:44:19 INFO - PROCESS | 32220 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:137.50 stddev:14.17 (10.3%) stddev-sans-first:15.01 15:44:19 INFO - PROCESS | 32220 | Values: 142.0 147.0 132.0 138.0 137.0 131.0 132.0 132.0 177.0 130.0 15:44:19 INFO - PROCESS | 32220 | 15:44:19 INFO - PROCESS | 32220 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:166.00 stddev:5.81 (3.5%) stddev-sans-first:6.16 15:44:19 INFO - PROCESS | 32220 | Values: 167.0 162.0 163.0 164.0 165.0 180.0 162.0 169.0 163.0 173.0 15:44:19 INFO - PROCESS | 32220 | 15:44:19 INFO - PROCESS | 32220 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.50 stddev:2.16 (3.3%) stddev-sans-first:1.64 15:44:19 INFO - PROCESS | 32220 | Values: 71.0 67.0 66.0 67.0 65.0 65.0 66.0 65.0 70.0 65.0 15:44:19 INFO - PROCESS | 32220 | -------- Summary: end -------- 15:44:19 INFO - PROCESS | 32220 | 15:44:20 INFO - TEST-INFO | 32220: exit 0 15:44:20 INFO - TEST-OK | kraken | took 61689ms 15:44:20 INFO - SUITE-END | took 1180s 15:44:21 INFO - Completed test suite (00:19:40) 15:44:21 INFO - javascript benchmark 15:44:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3082.1678146900335, 3109.502479603264, 3111.1133327001794, 3137.5764271823296, 3154.3218208085273, 5231.921521177185, 5317.255584218207, 5319.281896943911, 5361.624686271957, 5367.033933891903, 5250.054990101789, 5289.814856480024, 5304.416514183436, 5326.121190003645, 5383.111786555213, 4799.5680388765, 4834.903301933977, 4835.395575553056, 4853.733044682541, 4870.951290487085, 4823.831165909194, 4935.259711043336, 4936.901261974758, 4941.925871111936, 4976.427710813248, 4910.1898186799135, 4952.678075925053, 4961.8015279388965, 4966.87582810429, 5011.072951503965, 4744.715317080986, 4788.377510923592, 4790.784414701347, 4801.4958429365115, 4887.266909963499, 4801.087793319293, 4803.255495398219, 4812.157872372356, 4812.398450193726, 4819.228923372279, 5156.278121063054, 5190.71451070191, 5250.05499010178, 5302.390225124122, 5316.893662126736, 5643.40744221859, 5646.774129034875, 5650.9152362714185, 5652.0391533439415, 5657.066584013633, 5621.606487545873, 5666.291713535808, 5685.260916080924, 5693.4875861172695, 5698.8290351289525, 5204.34945631796, 5263.078961181778, 5276.34045744282, 5328.8401347959625, 5329.680219186861, 5771.192033115367, 5826.737796799154, 5827.067669172912, 5830.416958304136, 5856.824295271149, 5619.8595035124445, 5627.296587926509, 5630.971845140748, 5637.887242255132, 5638.915416268759, 5494.8076817312, 5532.419095994943, 5668.178114173422, 5684.8294551163535, 5692.601517893708, 5675.801346952837, 5701.657900525899, 5708.80019199326, 5711.771529138871, 5712.485876271156, 5657.8019769307875, 5662.235598194191, 5666.46168613981, 5667.8866422672145, 5669.886602267931, 4435.556444355539, 4436.489803672619, 4446.510883802779, 4451.087527056946, 4480.193565158303, 3886.0090676877217, 3892.922141557153, 3895.8831235062994, 3946.8421263149726, 3951.664108550748, 5311.9734401328515, 5359.571234301325, 5399.865003374868, 5406.729663516809, 5449.5640348772795, 5656.943430565641, 5676.0, 5678.432156784289, 5680.5455563554815, 5690.630109042899, 5268.446813084647, 5299.152135658276, 5399.2980912481125, 5400.054990376669, 5463.535599474089, 4933.506649335038, 4967.90064198714, 4980.452150263468, 5037.924431133536, 5064.848054558369, 6024.487918526975, 6024.819255422344, 6025.216721826135, 6036.396360363929, 6040.697965101727, 5548.4174161712435, 5753.309602847685, 5758.71206439668, 5768.336641286138, 5772.0, 5828.504577110993, 5917.142014407801, 5941.049432090845, 5952.494038006645, 6064.06007068905, 5593.105103183471, 5642.746076426489, 5643.238162848127, 5643.971780141073, 5646.802361917477, 5694.430556944272, 5752.194692742935, 5761.625494342854, 5763.106718458645, 5764.942350576441, 5444.8366549003595, 5463.508284254436, 5471.808486703106, 5485.753141108739, 5487.204355368529, 5487.4238204987905, 5499.285092937893, 5508.3114610673665, 5513.641613295123, 5546.833594992157, 5455.318085239345, 5455.454454554671, 5458.317710286215, 5460.26286451324, 5504.614676972574, 5476.315460567429, 5493.478119578634, 5569.415211402907, 5577.051901176891, 5607.271054762855, 5509.531689806411, 5547.528460080938, 5553.666779993213, 5573.916391254053, 5600.103983362643], "value": 5257.531421312674, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.6024182533206, 564.0439455123565, 582.9038208695565, 582.9183914252005, 599.0893841361132, 30036.549451758216, 40954.79522602387, 41761.58238417619, 41868.16263674725, 41908.58091419085, 43722.0, 44164.11671766563, 44167.55832441683, 44241.55758442415, 44258.55741442584, 7936.0873499547715, 8523.105073967237, 8678.088800675932, 8679.132086791333, 8680.652773889036, 7799.064112306532, 10067.546960386764, 10312.948435257813, 10320.483975801217, 10652.41411722355, 10394.532246048946, 10468.633597824077, 10469.73825654361, 10475.633352832652, 10476.947615261914, 10368.222383321243, 10439.0, 10441.738956526071, 10458.529366178464, 10459.372437653727, 10158.238132140119, 10229.897701022968, 10232.079112879877, 10238.89761102387, 10242.48787560619, 40080.0, 40457.0, 40485.59514404848, 40553.59446405528, 40554.79722601368, 3352.346292472969, 3405.523226748257, 3472.722182225416, 3553.342631613134, 3754.710720882693, 29599.70400295991, 31475.213119671964, 32302.0, 32363.19092022718, 32455.51316730251, 4129.8967525811795, 4207.26372884744, 4223.87328380146, 4268.146370725867, 4394.62645675118, 330568.0, 332036.0, 332446.0, 332596.0, 333178.0, 58915.0, 59279.0, 59453.70273148607, 59698.403015969285, 59780.70109649424, 62429.37570624326, 62431.68784156141, 62457.375426245155, 62541.0, 62576.68711656413, 14456.204908729911, 14964.17697026674, 14966.625834354229, 14975.475858344906, 14981.625459363386, 10429.26995110335, 10691.518881650345, 11201.551937922555, 11444.542218311175, 11509.827352589718, 18058.819411805714, 18659.44021679352, 18798.812011879705, 18807.3417430392, 19094.427167185007, 6794.218664853506, 7067.540609860343, 7278.454115941326, 7298.722723523362, 7309.342159205697, 947.2611363136764, 966.1642679082543, 1089.4334945828125, 1104.6962085426412, 1149.252985559393, 32423.837880810446, 32831.83584082064, 32839.0, 32916.50625240623, 33157.33685326328, 1048.3963216607222, 1118.669992352258, 1145.6963904565298, 1166.719987203065, 1173.096715529055, 16740.581485462717, 16880.57798555046, 17010.659786804194, 17120.14399280031, 17388.826111738974, 553521.0, 555141.0, 555318.0, 555518.0, 556955.0, 56054.0, 56507.43492565022, 56632.71683641555, 56658.0, 56734.14898776521, 1166.7491489329834, 1186.291739894549, 1268.1630124118037, 1304.39345704248, 1333.9466421343038, 29145.7085429143, 33095.834520827244, 33169.66830331762, 33254.83372583122, 33546.66453335436, 48475.75762121167, 48891.26663100127, 49128.75435622942, 49150.5084949146, 49172.0, 354340.0, 354968.0, 357671.0, 358554.0, 359806.0, 27421.31446713848, 27757.306067348476, 28166.71833281641, 28250.2937426566, 28589.428211436072, 46090.769546152056, 46357.53642463532, 47574.76212618915, 50544.0, 50723.0, 40324.1935161301, 40528.3920741195, 40834.183316332914, 41474.58525414828, 42295.36556951587, 40784.79607601943, 41689.0, 41800.16399671929, 42081.78959105307, 42193.36709949292, 40870.1825963485, 41292.0, 42339.0, 42638.57361426346, 42644.0, 34329.65670343264, 36964.873627993096, 37033.62966370302, 37216.0, 37932.43101353427, 27981.160565183076, 28112.71887281101, 28314.85842570774, 28380.574291385234, 28384.290392740346], "value": 20022.081625330826, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.79520456555747, 393.48846499550575, 406.3944722363678, 413.24788884230696, 423.7076417272082, 13390.397432115566, 15271.083734975895, 18826.811731882677, 18931.242750289974, 19431.708524372112, 18018.459446216602, 18274.177662005208, 18758.343457978972, 19305.324313649024, 19331.51671208217, 4631.8842028949375, 5528.612997090196, 5741.1101279301565, 5743.655380677152, 5748.166515855199, 4185.455890734201, 4369.257226271526, 5651.491365777079, 5724.685142317171, 6102.420270074358, 6335.524835637322, 6339.683015849212, 6347.143135676693, 6348.587341822767, 6361.0, 5444.809431669893, 5715.2855893013375, 5751.511121554673, 5817.767289308465, 6337.746490140389, 5453.481919217668, 5640.464155905223, 5647.29408823897, 5652.9152062719095, 5654.0, 13492.865071349357, 13902.304884755722, 13908.930455347658, 13910.58268251944, 13917.443302267897, 2205.128974055255, 2301.7813307735737, 2586.1982785336604, 2687.5296823055887, 2901.3036871150985, 10248.692539223835, 10276.177905767521, 10428.322159059713, 10844.945775271073, 10958.56165753369, 1903.1530968718926, 1951.2000079967145, 1974.0, 1974.6544354737864, 1976.575036367188, 79931.6003419985, 84414.57792710997, 84683.0, 84795.5760221201, 85048.0, 10874.347539147677, 10982.450877456255, 11082.501287442085, 11132.888671113347, 11247.775044499063, 15654.295556699975, 15667.373305067898, 15678.05931644105, 15683.921580392025, 15696.372145114296, 7617.771466856003, 7789.493682910593, 7815.491993020435, 8099.433039687283, 8106.959465202636, 7402.7409040683315, 7406.111266647929, 7445.8883116753295, 7602.514516435219, 7641.159472458025, 4740.336352910595, 4788.688735232199, 4795.352627395257, 4966.826161084345, 4970.925436118461, 1832.3220408448958, 1844.0, 1978.6644015289621, 1988.33390814076, 1998.7201791749167, 884.3588398411229, 916.9679061232958, 1007.2546315726456, 1029.4801125431609, 1066.5147357952112, 19799.60400791976, 19977.500562486053, 19988.600227995357, 20111.49721256951, 20231.0, 984.227381505529, 990.980180396388, 992.5285489392625, 1004.3622299839508, 1007.5717819926502, 10848.78302433947, 11093.16801239894, 11139.888601113886, 11147.219694621299, 11155.219134660496, 464296.0, 464903.0, 473945.0, 476087.0, 495466.0, 90551.54724226336, 90942.0, 91849.0, 92524.0, 92561.0, 958.4919992404037, 967.9661211857551, 989.7129832348683, 994.3636072913341, 998.3311181508407, 16552.83447165561, 16871.072091035112, 17026.574335641708, 17613.471595852145, 18011.90994045074, 38832.0, 39988.800055999534, 42820.35769463398, 43328.350074748276, 43708.56291437045, 58939.0, 60044.699776500835, 60760.08859867017, 60778.0, 61034.694826525585, 8225.0, 8393.916060839558, 8641.0, 8722.127787221227, 8962.417442866194, 11288.322700637988, 12972.935135324264, 13086.476540938636, 13101.803472948104, 13379.3979270935, 11611.361375124448, 11658.94170529142, 11757.882421175678, 11850.644480665595, 12273.631791046282, 10629.0, 11228.550857965916, 11264.718382040186, 11303.321800691985, 11307.265027773168, 10881.564737410416, 11233.438328083399, 11275.66173014811, 11776.70558236051, 11822.881771182178, 8583.570821458778, 8619.138086191331, 8665.17680820321, 8805.16350946659, 8810.867836982323, 10112.848307275544, 11175.832362514731, 11198.608048718255, 11211.215214934877, 11818.40907954616], "value": 9060.566965625245, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1411.0686946615235, 1461.021115852379, 1536.4161618584935, 1682.4952514245724, 1712.7773389459376, 7173.318534739192, 7389.630518474069, 7849.489783164097, 8133.552654603995, 8137.226963438464, 7728.188540203282, 7980.244346243831, 7985.1216366199815, 7987.440879138463, 7993.640286187121, 2271.1029143488313, 2272.8295377846644, 2278.829087818412, 2294.0823670531836, 2310.3069079276233, 2031.289048832904, 2092.225876425717, 2294.6443301288327, 2314.2363020203293, 2373.193114341124, 2250.3923940536047, 2297.7012988311494, 2305.7924786769186, 2320.779525945041, 2334.8482348647285, 2293.2203050962753, 2295.621222498286, 2314.247869442438, 2318.466752646884, 2329.848559843622, 2328.0571368595747, 2334.7198336199594, 2343.3907184132077, 2354.0348457132495, 2382.0948039744785, 8017.518948863087, 8183.918160818375, 8190.099089100254, 8193.344532437392, 8196.754097377028, 4827.131116399047, 4988.102141614508, 4988.87527811804, 4993.201087825967, 4997.250412438127, 3137.98567029725, 3357.0600231935096, 3434.553508043963, 3455.291665208626, 3464.532288141094, 1007.3099926550263, 1083.4745148602922, 1092.9180311476591, 1097.7310558913118, 1115.9218854680175, 11321.150913681508, 11323.263987840846, 11342.149338799623, 11359.943200283946, 11375.715607109805, 4238.449001629769, 4426.667999900021, 4523.25366314561, 4544.681872268976, 4547.590716835501, 9239.72280831576, 9285.814283714288, 9337.0, 9343.813123737487, 9355.0, 4953.083679519301, 4957.281194226817, 4963.875903102451, 4980.576650984707, 4982.177940639754, 4475.239209334421, 4550.544945505423, 4614.1694494991225, 4622.237330840374, 4622.2835460503675, 3632.8365223565, 3661.8718344857803, 3722.0694826293425, 3748.2878253131817, 3771.07608635886, 1102.388174563109, 1109.8446217529552, 1185.8399116119385, 1200.4537935239446, 1214.769193853165, 804.6097642643314, 945.7730144765344, 965.4159233663673, 985.3102828020415, 987.8483707465601, 5566.805161819398, 5691.174779656926, 5693.572982026365, 5889.852753681193, 5937.079752638348, 888.5068786823246, 893.4371346052076, 905.968291109808, 913.2693844924167, 933.9346245762868, 3764.3976963685677, 3913.412988051815, 3925.097227637659, 3945.9802700986884, 3962.5641179470235, 9882.357646752938, 10166.135878450266, 10171.694849154537, 10172.949135254275, 10184.338018028804, 9507.096825801538, 10074.44590547527, 10103.0, 10105.14106300958, 10113.241506887012, 7329.74345897891, 7718.92281077182, 7730.033745781778, 7730.951297906059, 7735.845283094307, 5329.360476742816, 5444.646098003617, 5546.112621980464, 5689.089745640677, 5756.453136951983, 8986.101389860962, 9071.954640226757, 9109.134632209929, 9149.954250228706, 9202.401843880127, 9094.317926155432, 9142.771430714285, 9268.58291376903, 9395.107464790834, 9508.619655213713, 7061.682224299816, 7347.26527347261, 7506.849863002819, 7509.1739908608915, 7510.098788145458, 7802.102758182881, 7987.081485629227, 8024.759257222293, 8043.718469853527, 8044.517328960281, 7052.858942821217, 7175.892361614684, 7222.133343998754, 7242.239564845615, 7386.113666359856, 6870.690818913261, 6925.58446493212, 7025.929740702528, 7118.145822501333, 7134.429245660439, 6556.475481961527, 6653.667316634052, 6709.329067093252, 6711.832204194934, 6727.125473688585, 4821.662483626113, 4846.660733748604, 4895.8041678332465, 4897.363342765418, 4956.702597844141, 4579.198640237879, 4590.265557510916, 4640.9535904640525, 4730.834420795256, 4879.0], "value": 4386.188120038447, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.2100639973662, 341.2407393549353, 348.99476507852387, 350.0757998882948, 351.0556602738631, 5041.596672266219, 5091.24689101315, 5132.743362831858, 5216.686998780076, 5221.425643179247, 5031.547160755531, 5073.188289873621, 5081.593472522199, 5106.374474123377, 5149.356330458692, 4095.9795201024026, 4117.155983023473, 4118.6499147572495, 4125.401816736571, 4153.563875793028, 4051.2932402411943, 4097.836086556535, 4160.563140870196, 4166.166766646667, 4168.62482376586, 4075.6331930126285, 4078.796060196993, 4080.571539988303, 4100.2414553307735, 4119.773412462313, 4063.7155399122075, 4073.959260407388, 4080.306347920846, 4094.5905409459115, 4108.322126849066, 3682.6685598296012, 3690.7785532867847, 3693.575238847513, 3697.7226707997006, 3702.389105797567, 4860.343853579757, 4983.975080124576, 5063.696178229318, 5071.46749591295, 5080.390353157644, 4711.042724111762, 4714.457837348715, 4720.693154944917, 4737.95262047382, 4751.928721069186, 5436.293281873371, 5444.700541470217, 5451.209574611659, 5451.291332126798, 5474.753636086346, 3904.3016287914566, 4024.63778259958, 4048.736832105904, 4059.7564146151326, 4071.3485842265095, 5588.6646801191655, 5589.469000444951, 5620.241267428885, 5626.493615574577, 5630.859228519279, 4141.503019637603, 4144.958550414518, 4153.979230103831, 4160.583941605815, 4165.083681590046, 4079.592040795956, 4158.542560318362, 4190.895227619273, 4196.748195108304, 4206.49522057349, 4664.79008444614, 4687.367205427224, 4689.132510485571, 4701.64737644678, 4727.432708075053, 5397.946020539823, 5426.8914621707345, 5435.972820135874, 5477.75350109246, 5486.533644640251, 1300.8829205371562, 1332.8933685305153, 1406.5709958462767, 1406.8944829137856, 1416.2423103639503, 934.6541779541477, 970.1753509516855, 977.9168770654431, 978.9916386122305, 983.8819341679044, 5104.591632669378, 5160.690358578498, 5167.793288268427, 5172.508611681884, 5182.807954170562, 5351.9296140772, 5378.865528361822, 5387.138057910715, 5403.324584426947, 5403.432639572867, 4904.975475122673, 5148.150555158357, 5162.66442681232, 5165.431802501722, 5165.50927661879, 2821.971780282212, 2836.744692977642, 2847.2454799478155, 2847.487452258572, 2865.20642373684, 5571.4150014248735, 5581.665100094007, 5603.6077474577205, 5614.803481878196, 5664.6034777566, 5329.25390445338, 5494.313210848644, 5497.917531237034, 5531.668099913937, 5532.585056120807, 5628.915566266509, 5633.324001119892, 5644.3508996465935, 5671.85212207229, 5690.292912126346, 5177.663451875616, 5297.0, 5350.411454740053, 5351.224072509386, 5354.7858085676135, 5252.2646829444675, 5270.209468579744, 5324.8136315228785, 5328.467153284795, 5348.491893270133, 5614.2701448811395, 5622.762992141722, 5636.239107720569, 5648.689322087324, 5660.773569057192, 3924.9215015700097, 3974.364101743707, 4029.730634850013, 4034.374671925856, 4034.556198818186, 5307.65500242483, 5330.760115794876, 5331.027519817692, 5346.984073026113, 5406.513413792777, 5271.759502211468, 5313.309269794902, 5418.106012507892, 5426.918596221139, 5441.809536666197, 5422.403535611001, 5438.700871452108, 5474.534664553557, 5480.738960318604, 5490.313710786152, 5247.536625826936, 5343.251944727664, 5417.945820541744, 5429.185622156708, 5445.428230035947, 5501.504864562208, 5514.862128446821, 5522.972385138049, 5530.253415788978, 5542.251796007487, 5429.321334833146, 5429.511343979061, 5436.755346009518, 5440.319960004999, 5448.5368743655645], "value": 4153.578748423545, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.9244035385577, 713.464901324007, 741.2513361504879, 750.6659536506254, 775.352580595203, 13354.26551539665, 14224.431022759103, 14231.430742770277, 14266.57200283992, 14326.570202893903, 13874.375653095609, 14016.789748153786, 14144.222067786268, 14153.433862645508, 14178.0, 652.7421668440963, 673.6093066021696, 746.902902622661, 770.6686124966262, 775.1008829757483, 774.5507605588773, 782.8277778888636, 783.9843203135933, 784.2627929746048, 785.3913217256614, 833.5540485840077, 834.0575150080431, 834.4200780457585, 834.5326617094447, 834.9749507514784, 682.4028974647184, 698.3016983016983, 795.8607243732324, 826.5123577089516, 827.028241815867, 604.2477115990575, 604.3684349854412, 606.429955841512, 607.8358843112379, 608.9056196289538, 13673.453061877513, 13699.0, 13739.450421983109, 13755.31223438824, 13765.242911639856, 13376.464941402332, 13748.243846588433, 14290.214038227894, 14389.474578728174, 14709.117452952856, 12757.55348562796, 12826.0, 12833.67915802103, 13210.66973325665, 13288.402021909038, 4149.398337241083, 4232.936505952413, 4297.0, 4302.956970430287, 4434.24617814969, 88461.55769221178, 91241.54379228127, 92356.29942909721, 92362.76372362777, 92468.0, 10878.564857405774, 10973.780524389467, 11231.887681123248, 11437.656870293904, 11498.367589782474, 20621.58756824855, 21478.355649330544, 21661.67507487389, 21667.133314667553, 21673.133074677153, 7720.613969301512, 7796.922030779733, 7847.372210223169, 7850.842983140419, 8016.839663206703, 4243.321068629005, 4272.914541709149, 4381.539938306496, 4409.713368631029, 4451.554844515587, 3174.841257937094, 3359.6136444308727, 3363.983180084133, 3406.6593340665736, 3412.1640198151613, 609.5641616244407, 610.1275176497562, 614.3825455417366, 615.0865964043392, 650.677914432359, 638.4828289085856, 724.1418918581497, 725.8475720098733, 737.1412304665113, 762.4510352546158, 9718.70843874685, 9899.406035637885, 10660.307080039927, 10839.458027098613, 10958.397288149068, 612.3233826621608, 668.3283300283282, 714.2821464428216, 716.9390601798801, 727.6907314391362, 4719.5752382285755, 4887.706737595756, 4913.263010548375, 4957.355543779286, 4987.675801072991, 84495.577522112, 87064.0, 87507.1249287499, 87752.56123719341, 88052.0, 66847.66576167186, 78449.0, 78483.0, 80531.59734201408, 82925.0, 71052.0, 71725.28274717186, 71729.64135179395, 71964.64017679878, 72248.63875680589, 9354.672586459441, 9536.141747242782, 9603.9039609603, 9618.470984095662, 9690.273229507957, 48141.518584813704, 48387.27419088787, 48932.75533622309, 49047.26429103638, 50190.0, 63153.68423157855, 66171.72853393326, 66187.33812661812, 66653.0, 68711.3128868705, 11819.0544756421, 12083.879161208275, 12140.939295303468, 12161.270323780602, 12267.0, 13598.388072536958, 13604.727905442034, 14287.499937502138, 14552.0, 14811.111333320036, 12970.935145324212, 13837.79243311331, 13846.307684615931, 13933.0, 14318.0, 12896.231646575216, 13382.397792099573, 13422.127561708458, 13614.727705445637, 13734.793978090536, 12195.756084878076, 12578.937105314415, 12842.422091006114, 12967.22196668203, 13241.668958276121, 10847.728806779895, 10923.344599324066, 11284.830727538929, 11338.0, 11677.591284305008, 9803.80392392134, 10868.728281793019, 11098.724142202404, 11229.606963756229, 11439.59961401347], "value": 7264.053556687755, "unit": "score"}], "name": "dromaeo_css", "value": 7082.672289717904, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 112.0, 111.0, 112.0, 113.0, 112.0, 111.0, 112.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 131.0, 124.0, 162.0, 122.0, 133.0, 123.0, 122.0, 152.0, 126.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 165.0, 164.0, 161.0, 162.0, 162.0, 161.0, 160.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 75.0, 76.0, 103.0, 78.0, 77.0, 76.0, 76.0, 96.0, 77.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 111.0, 83.0, 81.0, 81.0, 102.0, 83.0, 82.0, 115.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 145.0, 146.0, 147.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 52.0, 54.0, 52.0, 51.0, 53.0, 51.0, 52.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 80.0, 87.0, 80.0, 81.0, 88.0, 81.0, 82.0, 81.0, 81.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 147.0, 132.0, 138.0, 137.0, 131.0, 132.0, 132.0, 177.0, 130.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 162.0, 163.0, 164.0, 165.0, 180.0, 162.0, 169.0, 163.0, 173.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 66.0, 67.0, 65.0, 65.0, 66.0, 65.0, 70.0, 65.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1508.4, "alertThreshold": 2.0}]} 15:44:21 INFO - Return code: 0 15:44:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:44:21 INFO - # TBPL SUCCESS # 15:44:21 INFO - Running post-action listener: _resource_record_post_action 15:44:21 INFO - [mozharness: 2016-11-26 23:44:21.531872Z] Finished run-tests step (success) 15:44:21 INFO - Running post-run listener: _resource_record_post_run 15:44:21 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 394047488; Read time: 0; Write time: 359564 15:44:21 INFO - TinderboxPrint: CPU usage
13.1% 15:44:21 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:44:21 INFO - TinderboxPrint: I/O write bytes / time
394,047,488 / 359,564 15:44:21 INFO - TinderboxPrint: CPU idle
8,300.4 (86.8%) 15:44:21 INFO - TinderboxPrint: CPU user
1,205.7 (12.6%) 15:44:21 INFO - TinderboxPrint: Swap in / out
0 / 0 15:44:21 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104009728; Read time: 0; Write time: 124628 15:44:21 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 290037760; Read time: 0; Write time: 234936 15:44:22 INFO - Running post-run listener: _upload_blobber_files 15:44:22 INFO - Blob upload gear active. 15:44:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:44:22 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 15:44:22 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'] 15:44:22 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 15:44:22 INFO - (blobuploader) - INFO - Open directory for files ... 15:44:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:44:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:44:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:23 INFO - (blobuploader) - INFO - Done attempting. 15:44:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:44:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:44:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:24 INFO - (blobuploader) - INFO - Done attempting. 15:44:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:44:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:44:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:27 INFO - (blobuploader) - INFO - Done attempting. 15:44:27 INFO - (blobuploader) - INFO - Iteration through files over. 15:44:27 INFO - Return code: 0 15:44:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:44:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:44:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3d1cf3bbc049dab43d33a0b121207dacf878849208aa0ec825da4a9d0d173c8e640c8fee0d530cf82d3a31a8bbfd08c00b7b2b38a297ffcbbb69087bd28b5e8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/08bc4c8fd8a931a5b25f9c5181f556c169d0e8f7e140c98d5f2d7e026494d6f5acf7b6fd8d323ab6ff9d5fc51a0c1bd4a45ed9d85701752c3a1aabe91adeec5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/100d822e8fa813c15a33019bdc5ca50baf72693edc8bfb35e9259849b2e6f3887d965447aecc77407b4b0a0b44645bb841b2ea271477f22db62db545c782b424"} 15:44:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:44:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:44:27 INFO - Contents: 15:44:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3d1cf3bbc049dab43d33a0b121207dacf878849208aa0ec825da4a9d0d173c8e640c8fee0d530cf82d3a31a8bbfd08c00b7b2b38a297ffcbbb69087bd28b5e8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/08bc4c8fd8a931a5b25f9c5181f556c169d0e8f7e140c98d5f2d7e026494d6f5acf7b6fd8d323ab6ff9d5fc51a0c1bd4a45ed9d85701752c3a1aabe91adeec5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/100d822e8fa813c15a33019bdc5ca50baf72693edc8bfb35e9259849b2e6f3887d965447aecc77407b4b0a0b44645bb841b2ea271477f22db62db545c782b424"} 15:44:27 INFO - Running post-run listener: copy_logs_to_upload_dir 15:44:27 INFO - Copying logs to upload dir... 15:44:27 INFO - mkdir: /builds/slave/test/build/upload/logs 15:44:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.758439 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-26 15:44:26.702526) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 15:44:26.705780) ========= 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=c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3d1cf3bbc049dab43d33a0b121207dacf878849208aa0ec825da4a9d0d173c8e640c8fee0d530cf82d3a31a8bbfd08c00b7b2b38a297ffcbbb69087bd28b5e8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/08bc4c8fd8a931a5b25f9c5181f556c169d0e8f7e140c98d5f2d7e026494d6f5acf7b6fd8d323ab6ff9d5fc51a0c1bd4a45ed9d85701752c3a1aabe91adeec5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/100d822e8fa813c15a33019bdc5ca50baf72693edc8bfb35e9259849b2e6f3887d965447aecc77407b4b0a0b44645bb841b2ea271477f22db62db545c782b424"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011814 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3d1cf3bbc049dab43d33a0b121207dacf878849208aa0ec825da4a9d0d173c8e640c8fee0d530cf82d3a31a8bbfd08c00b7b2b38a297ffcbbb69087bd28b5e8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/08bc4c8fd8a931a5b25f9c5181f556c169d0e8f7e140c98d5f2d7e026494d6f5acf7b6fd8d323ab6ff9d5fc51a0c1bd4a45ed9d85701752c3a1aabe91adeec5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/100d822e8fa813c15a33019bdc5ca50baf72693edc8bfb35e9259849b2e6f3887d965447aecc77407b4b0a0b44645bb841b2ea271477f22db62db545c782b424"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 15:44:26.731559) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 15:44:26.731979) ========= 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=c7c495d6f76fb52e1ad9f659000001da-1480193693.184702-1261577617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 15:44:26.814991) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 15:44:26.815323) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 15:44:26.815599) ========= ========= Total master_lag: 0.21 =========