builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1475783289.51 results: success (0) buildid: 20161006124021 builduid: 509ab58e365844ddb86df85b1e786429 revision: 9d162f236562f4ff038e095ce1af5d31eb578f52 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 12:48:09.505525) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 12:48:09.505939) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 12:48:09.506210) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 12:48:09.520483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 12:48:09.520778) ========= 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=db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 12:48:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-10-06 12:48:09 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141502 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 12:48:09.675743) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 12:48:09.676066) ========= 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=db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015879 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 12:48:09.725484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 12:48:09.725847) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 9d162f236562f4ff038e095ce1af5d31eb578f52 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 9d162f236562f4ff038e095ce1af5d31eb578f52 --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=db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 12:48:09,938 truncating revision to first 12 chars 2016-10-06 12:48:09,938 Setting DEBUG logging. 2016-10-06 12:48:09,938 attempt 1/10 2016-10-06 12:48:09,938 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/9d162f236562?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 12:48:10,239 unpacking tar archive at: autoland-9d162f236562/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659276 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 12:48:10.496333) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 12:48:10.496695) ========= script_repo_revision: 9d162f236562f4ff038e095ce1af5d31eb578f52 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 12:48:10.497144) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 12:48:10.497454) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 12:48:10.507895) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-10-06 12:48:10.508202) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:48:10 INFO - MultiFileLogger online at 20161006 12:48:10 in /builds/slave/test 12:48:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 12:48:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:48:10 INFO - {'append_to_log': False, 12:48:10 INFO - 'base_work_dir': '/builds/slave/test', 12:48:10 INFO - 'blob_upload_branch': 'Autoland', 12:48:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:48:10 INFO - 'branch': 'Autoland', 12:48:10 INFO - 'buildbot_json_path': 'buildprops.json', 12:48:10 INFO - 'config_files': ('talos/linux_config.py',), 12:48:10 INFO - 'default_actions': ('clobber', 12:48:10 INFO - 'read-buildbot-config', 12:48:10 INFO - 'download-and-extract', 12:48:10 INFO - 'populate-webroot', 12:48:10 INFO - 'create-virtualenv', 12:48:10 INFO - 'install', 12:48:10 INFO - 'run-tests'), 12:48:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:48:10 INFO - 'download_minidump_stackwalk': True, 12:48:10 INFO - 'download_symbols': 'ondemand', 12:48:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:48:10 INFO - 'tooltool.py': '/tools/tooltool.py', 12:48:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:48:10 INFO - '/tools/misc-python/virtualenv.py')}, 12:48:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:48:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:48:10 INFO - 'installer_path': 'installer.exe', 12:48:10 INFO - 'log_level': 'info', 12:48:10 INFO - 'log_name': 'talos', 12:48:10 INFO - 'log_to_console': True, 12:48:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:48:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:48:10 INFO - 'opt_config_files': (), 12:48:10 INFO - 'pip_index': False, 12:48:10 INFO - 'sps_profile': False, 12:48:10 INFO - 'sps_profile_interval': 0, 12:48:10 INFO - 'suite': 'dromaeojs-e10s', 12:48:10 INFO - 'system_bits': '32', 12:48:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:48:10 INFO - 'title': 'talos-linux64-ix-049', 12:48:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:48:10 INFO - 'use_talos_json': True, 12:48:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:48:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:48:10 INFO - 'work_dir': 'build'} 12:48:10 INFO - [mozharness: 2016-10-06 19:48:10.821539Z] Running clobber step. 12:48:10 INFO - Running pre-action listener: _resource_record_pre_action 12:48:10 INFO - Running main action method: clobber 12:48:10 INFO - rmtree: /builds/slave/test/build 12:48:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:48:11 INFO - Running post-action listener: _resource_record_post_action 12:48:11 INFO - [mozharness: 2016-10-06 19:48:11.285439Z] Finished clobber step (success) 12:48:11 INFO - [mozharness: 2016-10-06 19:48:11.285540Z] Running read-buildbot-config step. 12:48:11 INFO - Running pre-action listener: _resource_record_pre_action 12:48:11 INFO - Running main action method: read_buildbot_config 12:48:11 INFO - Using buildbot properties: 12:48:11 INFO - { 12:48:11 INFO - "project": "", 12:48:11 INFO - "product": "firefox", 12:48:11 INFO - "script_repo_revision": "production", 12:48:11 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 12:48:11 INFO - "repository": "", 12:48:11 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 12:48:11 INFO - "buildid": "20161006124021", 12:48:11 INFO - "stage_platform": "linux64-pgo", 12:48:11 INFO - "basedir": "/builds/slave/test", 12:48:11 INFO - "buildnumber": 334, 12:48:11 INFO - "platform": "ubuntu64_hw", 12:48:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:48:11 INFO - "slavebuilddir": "test", 12:48:11 INFO - "branch": "autoland", 12:48:11 INFO - "revision": "9d162f236562f4ff038e095ce1af5d31eb578f52", 12:48:11 INFO - "slavename": "talos-linux64-ix-049", 12:48:11 INFO - "builduid": "509ab58e365844ddb86df85b1e786429", 12:48:11 INFO - "repo_path": "integration/autoland" 12:48:11 INFO - } 12:48:11 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:48:11 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 12:48:11 INFO - Running post-action listener: _resource_record_post_action 12:48:11 INFO - [mozharness: 2016-10-06 19:48:11.287930Z] Finished read-buildbot-config step (success) 12:48:11 INFO - [mozharness: 2016-10-06 19:48:11.288019Z] Running download-and-extract step. 12:48:11 INFO - Running pre-action listener: _resource_record_pre_action 12:48:11 INFO - Running main action method: download_and_extract 12:48:11 INFO - mkdir: /builds/slave/test/build/tests 12:48: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')]} 12:48:11 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:48:11 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:48:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:48:11 INFO - Downloaded 1361 bytes. 12:48:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:48:11 INFO - Using the following test package requirements: 12:48:11 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:48:11 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:48:11 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:48:11 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:11 INFO - u'jsshell-linux-x86_64.zip'], 12:48:11 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:48:11 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:48:11 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:48:11 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:48:11 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:48:11 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:48:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:48:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:48:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:48:11 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:48:11 INFO - Http code: 200 12:48:11 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 12:48:11 INFO - x-amz-cf-id: im6S-IWRcUQRfxm7_9GKJYGfJLF0tHCtkG3Io-ExL6OejtzMgeJ1Yg== 12:48:11 INFO - x-amz-replication-status: COMPLETED 12:48:11 INFO - x-amz-version-id: nnFob8bLHVNeqU4TkoVv2zzvWDBtKkEy 12:48:11 INFO - Expected file size: 22017868 12:48:11 INFO - Obtained file size: 22017868 12:48:15 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:48:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:48:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:48:15 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:48:15 INFO - Http code: 200 12:48:15 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 12:48:15 INFO - x-amz-cf-id: Ydd_Ce6WrgI46SaM4lbM3Wh6vYO66o_csMfZwqXOD65HcGfG_0pdPg== 12:48:15 INFO - x-amz-replication-status: COMPLETED 12:48:15 INFO - x-amz-version-id: nnFob8bLHVNeqU4TkoVv2zzvWDBtKkEy 12:48:16 INFO - Expected file size: 22017868 12:48:16 INFO - Obtained file size: 22017868 12:48:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:48:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:48:20 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:48:20 INFO - Http code: 200 12:48:20 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 12:48:20 INFO - x-amz-cf-id: EM7K4Z1RWDCVPVR0fGoa5MkS2HtTPe0hqVGHIWLvqz0WRW6dVCGV_g== 12:48:20 INFO - x-amz-replication-status: COMPLETED 12:48:20 INFO - x-amz-version-id: hRujhaT3vQaLv5WwEYEO4fdSh5QxLRve 12:48:20 INFO - Expected file size: 14409006 12:48:20 INFO - Obtained file size: 14409006 12:48:20 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')]} 12:48:20 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:48:20 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:48:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:48:21 INFO - Downloaded 59701102 bytes. 12:48:21 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:48:21 INFO - mkdir: /builds/slave/test/properties 12:48:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:48:21 INFO - Writing to file /builds/slave/test/properties/build_url 12:48:21 INFO - Contents: 12:48:21 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:48:21 INFO - Running post-action listener: _resource_record_post_action 12:48:21 INFO - Running post-action listener: set_extra_try_arguments 12:48:21 INFO - [mozharness: 2016-10-06 19:48:21.871539Z] Finished download-and-extract step (success) 12:48:21 INFO - [mozharness: 2016-10-06 19:48:21.871766Z] Running populate-webroot step. 12:48:21 INFO - Running pre-action listener: _resource_record_pre_action 12:48:21 INFO - Running main action method: populate_webroot 12:48:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:48:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:48:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:48:21 INFO - '--tppagecycles', 12:48:21 INFO - '7'], 12:48:21 INFO - 'tests': ['tsvgm']}}, 12:48:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:48:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:48:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:48:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:48:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:48:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:48:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:21 INFO - 'talos_options': ['--disable-e10s'], 12:48:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:21 INFO - 'talos_options': ['--disable-e10s'], 12:48:21 INFO - 'tests': ['damp', 'tps']}, 12:48:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:21 INFO - 'tests': ['damp', 'tps']}, 12:48:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:48:21 INFO - 'tests': ['dromaeo_dom']}, 12:48:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:48:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:48:21 INFO - 'tests': ['basic_compositor_video']}, 12:48:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:48:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:48:21 INFO - 'tests': ['a11yr', 12:48:21 INFO - 'ts_paint', 12:48:21 INFO - 'tpaint', 12:48:21 INFO - 'sessionrestore', 12:48:21 INFO - 'sessionrestore_no_auto_restore', 12:48:21 INFO - 'tabpaint']}, 12:48:21 INFO - 'other-e10s': {'tests': ['a11yr', 12:48:21 INFO - 'ts_paint', 12:48:21 INFO - 'tpaint', 12:48:21 INFO - 'sessionrestore', 12:48:21 INFO - 'sessionrestore_no_auto_restore', 12:48:21 INFO - 'tabpaint']}, 12:48:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:48:21 INFO - 'ts_paint', 12:48:21 INFO - 'tpaint', 12:48:21 INFO - 'sessionrestore', 12:48:21 INFO - 'sessionrestore_no_auto_restore', 12:48:21 INFO - 'tabpaint']}, 12:48:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:48:21 INFO - 'ts_paint', 12:48:21 INFO - 'tpaint', 12:48:21 INFO - 'sessionrestore', 12:48:21 INFO - 'sessionrestore_no_auto_restore', 12:48:21 INFO - 'tabpaint']}, 12:48:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:48:21 INFO - 'tests': ['a11yr', 12:48:21 INFO - 'ts_paint', 12:48:21 INFO - 'tpaint', 12:48:21 INFO - 'sessionrestore', 12:48:21 INFO - 'sessionrestore_no_auto_restore', 12:48:21 INFO - 'tabpaint']}, 12:48:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:48:21 INFO - 'tests': ['a11yr', 12:48:21 INFO - 'ts_paint', 12:48:21 INFO - 'tpaint', 12:48:21 INFO - 'sessionrestore', 12:48:21 INFO - 'sessionrestore_no_auto_restore', 12:48:21 INFO - 'tabpaint']}, 12:48:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:48:21 INFO - 'tests': ['tsvgx', 12:48:21 INFO - 'tsvgr_opacity', 12:48:21 INFO - 'tart', 12:48:21 INFO - 'tscrollx', 12:48:21 INFO - 'cart']}, 12:48:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:48:21 INFO - 'tsvgr_opacity', 12:48:21 INFO - 'tart', 12:48:21 INFO - 'tscrollx', 12:48:21 INFO - 'cart']}, 12:48:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:21 INFO - 'talos_options': ['--disable-e10s'], 12:48:21 INFO - 'tests': ['tp5o']}, 12:48:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:21 INFO - 'tests': ['tp5o']}, 12:48:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:21 INFO - 'talos_options': ['--disable-e10s', 12:48:21 INFO - '--xperf_path', 12:48:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:21 INFO - 'tests': ['tp5n']}, 12:48:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:21 INFO - 'talos_options': ['--xperf_path', 12:48:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:21 INFO - 'tests': ['tp5n']}}, 12:48:21 INFO - 'talos.zip': {'path': '', 12:48:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:48:21 INFO - Running post-action listener: _resource_record_post_action 12:48:21 INFO - [mozharness: 2016-10-06 19:48:21.890789Z] Finished populate-webroot step (success) 12:48:21 INFO - [mozharness: 2016-10-06 19:48:21.890878Z] Running create-virtualenv step. 12:48:21 INFO - Running pre-action listener: _resource_record_pre_action 12:48:21 INFO - Running main action method: create_virtualenv 12:48:21 INFO - Creating virtualenv /builds/slave/test/build/venv 12:48:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:48:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:48:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:48:21 INFO - Using real prefix '/usr' 12:48:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:48:22 INFO - Installing distribute.............................................................................................................................................................................................done. 12:48:24 INFO - Installing pip.................done. 12:48:24 INFO - Return code: 0 12:48:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:48:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:48:24 INFO - Reading from file tmpfile_stdout 12:48:24 INFO - Output received: 12:48:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:48:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc17a1e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b317b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0790>, '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 0x2bc1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc1b20>, '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': 'db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647', '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 12:48:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:48:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:48:24 INFO - Using env: {'DISPLAY': ':0', 12:48:24 INFO - 'HOME': '/home/cltbld', 12:48:24 INFO - 'LANG': 'en_US.UTF-8', 12:48:24 INFO - 'LANGUAGE': 'en_US:en', 12:48:24 INFO - 'LOGNAME': 'cltbld', 12:48:24 INFO - 'MAIL': '/var/mail/cltbld', 12:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:24 INFO - 'MOZ_NO_REMOTE': '1', 12:48:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:24 INFO - 'NO_EM_RESTART': '1', 12:48:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:24 INFO - 'PWD': '/builds/slave/test', 12:48:24 INFO - 'SHELL': '/bin/bash', 12:48:24 INFO - 'SHLVL': '1', 12:48:24 INFO - 'TERM': 'linux', 12:48:24 INFO - 'TMOUT': '86400', 12:48:24 INFO - 'USER': 'cltbld', 12:48:24 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647', 12:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:24 INFO - '_': '/tools/buildbot/bin/python'} 12:48:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:48:24 INFO - Cleaning up... 12:48:24 INFO - Return code: 0 12:48:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc17a1e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b317b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0790>, '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 0x2bc1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc1b20>, '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': 'db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647', '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 12:48:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:48:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:48:24 INFO - Using env: {'DISPLAY': ':0', 12:48:24 INFO - 'HOME': '/home/cltbld', 12:48:24 INFO - 'LANG': 'en_US.UTF-8', 12:48:24 INFO - 'LANGUAGE': 'en_US:en', 12:48:24 INFO - 'LOGNAME': 'cltbld', 12:48:24 INFO - 'MAIL': '/var/mail/cltbld', 12:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:24 INFO - 'MOZ_NO_REMOTE': '1', 12:48:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:24 INFO - 'NO_EM_RESTART': '1', 12:48:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:24 INFO - 'PWD': '/builds/slave/test', 12:48:24 INFO - 'SHELL': '/bin/bash', 12:48:24 INFO - 'SHLVL': '1', 12:48:24 INFO - 'TERM': 'linux', 12:48:24 INFO - 'TMOUT': '86400', 12:48:24 INFO - 'USER': 'cltbld', 12:48:24 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647', 12:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:24 INFO - '_': '/tools/buildbot/bin/python'} 12:48:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:25 INFO - Downloading/unpacking psutil>=3.1.1 12:48:25 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 12:48:25 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 12:48:25 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 12:48:25 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 12:48:25 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 12:48:25 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 12:48:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:48:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:27 INFO - Installing collected packages: psutil 12:48:27 INFO - Running setup.py install for psutil 12:48:27 INFO - building 'psutil._psutil_linux' extension 12:48:27 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 12:48:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:48:27 INFO - building 'psutil._psutil_posix' extension 12:48:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:48:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:48:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:27 INFO - Successfully installed psutil 12:48:27 INFO - Cleaning up... 12:48:27 INFO - Return code: 0 12:48:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc17a1e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b317b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0790>, '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 0x2bc1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc1b20>, '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': 'db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647', '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 12:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:48:27 INFO - Using env: {'DISPLAY': ':0', 12:48:27 INFO - 'HOME': '/home/cltbld', 12:48:27 INFO - 'LANG': 'en_US.UTF-8', 12:48:27 INFO - 'LANGUAGE': 'en_US:en', 12:48:27 INFO - 'LOGNAME': 'cltbld', 12:48:27 INFO - 'MAIL': '/var/mail/cltbld', 12:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:27 INFO - 'MOZ_NO_REMOTE': '1', 12:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:27 INFO - 'NO_EM_RESTART': '1', 12:48:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:27 INFO - 'PWD': '/builds/slave/test', 12:48:27 INFO - 'SHELL': '/bin/bash', 12:48:27 INFO - 'SHLVL': '1', 12:48:27 INFO - 'TERM': 'linux', 12:48:27 INFO - 'TMOUT': '86400', 12:48:27 INFO - 'USER': 'cltbld', 12:48:27 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647', 12:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:27 INFO - '_': '/tools/buildbot/bin/python'} 12:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:48:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:48:29 INFO - Installing collected packages: mozsystemmonitor 12:48:29 INFO - Running setup.py install for mozsystemmonitor 12:48:29 INFO - Successfully installed mozsystemmonitor 12:48:29 INFO - Cleaning up... 12:48:29 INFO - Return code: 0 12:48:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc17a1e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b317b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0790>, '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 0x2bc1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc1b20>, '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': 'db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647', '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 12:48:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:48:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:48:29 INFO - Using env: {'DISPLAY': ':0', 12:48:29 INFO - 'HOME': '/home/cltbld', 12:48:29 INFO - 'LANG': 'en_US.UTF-8', 12:48:29 INFO - 'LANGUAGE': 'en_US:en', 12:48:29 INFO - 'LOGNAME': 'cltbld', 12:48:29 INFO - 'MAIL': '/var/mail/cltbld', 12:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:29 INFO - 'MOZ_NO_REMOTE': '1', 12:48:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:29 INFO - 'NO_EM_RESTART': '1', 12:48:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:29 INFO - 'PWD': '/builds/slave/test', 12:48:29 INFO - 'SHELL': '/bin/bash', 12:48:29 INFO - 'SHLVL': '1', 12:48:29 INFO - 'TERM': 'linux', 12:48:29 INFO - 'TMOUT': '86400', 12:48:29 INFO - 'USER': 'cltbld', 12:48:29 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647', 12:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:29 INFO - '_': '/tools/buildbot/bin/python'} 12:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:30 INFO - Downloading/unpacking jsonschema==2.5.1 12:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:48:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:32 INFO - Downloading functools32-3.2.3-2.tar.gz 12:48:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:48:32 INFO - warning: no files found matching '*.txt' 12:48:32 INFO - no previously-included directories found matching 'build' 12:48:32 INFO - no previously-included directories found matching 'dist' 12:48:32 INFO - no previously-included directories found matching '.git*' 12:48:32 INFO - Installing collected packages: jsonschema, functools32 12:48:32 INFO - Running setup.py install for functools32 12:48:32 INFO - warning: no files found matching '*.txt' 12:48:32 INFO - no previously-included directories found matching 'build' 12:48:32 INFO - no previously-included directories found matching 'dist' 12:48:32 INFO - no previously-included directories found matching '.git*' 12:48:32 INFO - Successfully installed jsonschema functools32 12:48:32 INFO - Cleaning up... 12:48:32 INFO - Return code: 0 12:48:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc17a1e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b317b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0790>, '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 0x2bc1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc1b20>, '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': 'db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647', '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 12:48:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:48:32 INFO - Using env: {'DISPLAY': ':0', 12:48:32 INFO - 'HOME': '/home/cltbld', 12:48:32 INFO - 'LANG': 'en_US.UTF-8', 12:48:32 INFO - 'LANGUAGE': 'en_US:en', 12:48:32 INFO - 'LOGNAME': 'cltbld', 12:48:32 INFO - 'MAIL': '/var/mail/cltbld', 12:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:32 INFO - 'MOZ_NO_REMOTE': '1', 12:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:32 INFO - 'NO_EM_RESTART': '1', 12:48:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:32 INFO - 'PWD': '/builds/slave/test', 12:48:32 INFO - 'SHELL': '/bin/bash', 12:48:32 INFO - 'SHLVL': '1', 12:48:32 INFO - 'TERM': 'linux', 12:48:32 INFO - 'TMOUT': '86400', 12:48:32 INFO - 'USER': 'cltbld', 12:48:32 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647', 12:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:32 INFO - '_': '/tools/buildbot/bin/python'} 12:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:48:32 INFO - Cleaning up... 12:48:32 INFO - Return code: 0 12:48:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc17a1e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b317b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0790>, '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 0x2bc1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc1b20>, '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': 'db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647', '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 12:48:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:48:32 INFO - Using env: {'DISPLAY': ':0', 12:48:32 INFO - 'HOME': '/home/cltbld', 12:48:32 INFO - 'LANG': 'en_US.UTF-8', 12:48:32 INFO - 'LANGUAGE': 'en_US:en', 12:48:32 INFO - 'LOGNAME': 'cltbld', 12:48:32 INFO - 'MAIL': '/var/mail/cltbld', 12:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:32 INFO - 'MOZ_NO_REMOTE': '1', 12:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:32 INFO - 'NO_EM_RESTART': '1', 12:48:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:32 INFO - 'PWD': '/builds/slave/test', 12:48:32 INFO - 'SHELL': '/bin/bash', 12:48:32 INFO - 'SHLVL': '1', 12:48:32 INFO - 'TERM': 'linux', 12:48:32 INFO - 'TMOUT': '86400', 12:48:32 INFO - 'USER': 'cltbld', 12:48:32 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647', 12:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:32 INFO - '_': '/tools/buildbot/bin/python'} 12:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:32 INFO - Downloading/unpacking blobuploader==1.2.4 12:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:34 INFO - Downloading blobuploader-1.2.4.tar.gz 12:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:48:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:48:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:35 INFO - Downloading docopt-0.6.1.tar.gz 12:48:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:48:35 INFO - Installing collected packages: blobuploader, requests, docopt 12:48:35 INFO - Running setup.py install for blobuploader 12:48:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:48:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:48:35 INFO - Running setup.py install for requests 12:48:36 INFO - Running setup.py install for docopt 12:48:36 INFO - Successfully installed blobuploader requests docopt 12:48:36 INFO - Cleaning up... 12:48:36 INFO - Return code: 0 12:48:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc17a1e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b317b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0790>, '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 0x2bc1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc1b20>, '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': 'db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647', '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 12:48:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:48:36 INFO - Using env: {'DISPLAY': ':0', 12:48:36 INFO - 'HOME': '/home/cltbld', 12:48:36 INFO - 'LANG': 'en_US.UTF-8', 12:48:36 INFO - 'LANGUAGE': 'en_US:en', 12:48:36 INFO - 'LOGNAME': 'cltbld', 12:48:36 INFO - 'MAIL': '/var/mail/cltbld', 12:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:36 INFO - 'MOZ_NO_REMOTE': '1', 12:48:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:36 INFO - 'NO_EM_RESTART': '1', 12:48:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:36 INFO - 'PWD': '/builds/slave/test', 12:48:36 INFO - 'SHELL': '/bin/bash', 12:48:36 INFO - 'SHLVL': '1', 12:48:36 INFO - 'TERM': 'linux', 12:48:36 INFO - 'TMOUT': '86400', 12:48:36 INFO - 'USER': 'cltbld', 12:48:36 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647', 12:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:36 INFO - '_': '/tools/buildbot/bin/python'} 12:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:48:36 INFO - Running setup.py (path:/tmp/pip-iKItCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:48:36 INFO - Running setup.py (path:/tmp/pip-cyWbif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:48:36 INFO - Running setup.py (path:/tmp/pip-RswGns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:48:36 INFO - Running setup.py (path:/tmp/pip-p6cNDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:48:36 INFO - Running setup.py (path:/tmp/pip-1tFT2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:48:36 INFO - Running setup.py (path:/tmp/pip-C6973r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:48:36 INFO - Running setup.py (path:/tmp/pip-ei2_03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:48:36 INFO - Running setup.py (path:/tmp/pip-sP3jsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:48:37 INFO - Running setup.py (path:/tmp/pip-0Xx_iS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:48:37 INFO - Running setup.py (path:/tmp/pip-CzZjmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:48:37 INFO - Running setup.py (path:/tmp/pip-2jlgp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:48:37 INFO - Running setup.py (path:/tmp/pip-WP1NIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:48:37 INFO - Running setup.py (path:/tmp/pip-MsI7i1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:48:37 INFO - Running setup.py (path:/tmp/pip-AaSSEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:37 INFO - Running setup.py (path:/tmp/pip-lsLWPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:48:37 INFO - Running setup.py (path:/tmp/pip-8Rbj9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:48:37 INFO - Running setup.py (path:/tmp/pip-B8uvNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:48:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:48:37 INFO - Running setup.py install for manifestparser 12:48:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:48:37 INFO - Running setup.py install for mozcrash 12:48:37 INFO - Running setup.py install for mozdebug 12:48:38 INFO - Running setup.py install for mozdevice 12:48:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:48:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:48:38 INFO - Running setup.py install for mozfile 12:48:38 INFO - Running setup.py install for mozhttpd 12:48:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:48:38 INFO - Running setup.py install for mozinfo 12:48:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:48:38 INFO - Running setup.py install for mozInstall 12:48:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:48:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:48:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:48:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:48:38 INFO - Running setup.py install for mozleak 12:48:38 INFO - Running setup.py install for mozlog 12:48:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:48:38 INFO - Running setup.py install for moznetwork 12:48:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:48:38 INFO - Running setup.py install for mozprocess 12:48:38 INFO - Running setup.py install for mozprofile 12:48:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:48:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:48:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:48:39 INFO - Running setup.py install for mozrunner 12:48:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:48:39 INFO - Running setup.py install for mozscreenshot 12:48:39 INFO - Running setup.py install for moztest 12:48:39 INFO - Running setup.py install for mozversion 12:48:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:48:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:48:39 INFO - Cleaning up... 12:48:39 INFO - Return code: 0 12:48:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc17a1e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b317b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0790>, '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 0x2bc1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc1b20>, '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': 'db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647', '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 12:48:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:48:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:48:39 INFO - Using env: {'DISPLAY': ':0', 12:48:39 INFO - 'HOME': '/home/cltbld', 12:48:39 INFO - 'LANG': 'en_US.UTF-8', 12:48:39 INFO - 'LANGUAGE': 'en_US:en', 12:48:39 INFO - 'LOGNAME': 'cltbld', 12:48:39 INFO - 'MAIL': '/var/mail/cltbld', 12:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:39 INFO - 'MOZ_NO_REMOTE': '1', 12:48:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:39 INFO - 'NO_EM_RESTART': '1', 12:48:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:39 INFO - 'PWD': '/builds/slave/test', 12:48:39 INFO - 'SHELL': '/bin/bash', 12:48:39 INFO - 'SHLVL': '1', 12:48:39 INFO - 'TERM': 'linux', 12:48:39 INFO - 'TMOUT': '86400', 12:48:39 INFO - 'USER': 'cltbld', 12:48:39 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647', 12:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:39 INFO - '_': '/tools/buildbot/bin/python'} 12:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:48:39 INFO - Running setup.py (path:/tmp/pip-knJy2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:48:39 INFO - Running setup.py (path:/tmp/pip-LzTEaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:48:39 INFO - Running setup.py (path:/tmp/pip-LBDl2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:48:39 INFO - Running setup.py (path:/tmp/pip-PyshxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:48:40 INFO - Running setup.py (path:/tmp/pip-lnedmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:48:40 INFO - Running setup.py (path:/tmp/pip-g8_FwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:48:40 INFO - Running setup.py (path:/tmp/pip-RRyFGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:48:40 INFO - Running setup.py (path:/tmp/pip-IUxSGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:48:40 INFO - Running setup.py (path:/tmp/pip-ln4uNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:48:40 INFO - Running setup.py (path:/tmp/pip-DUzJfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:48:40 INFO - Running setup.py (path:/tmp/pip-U54o3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:48:40 INFO - Running setup.py (path:/tmp/pip-VJSQTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:48:40 INFO - Running setup.py (path:/tmp/pip-7b0qgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:48:40 INFO - Running setup.py (path:/tmp/pip-xbffuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:40 INFO - Running setup.py (path:/tmp/pip-5gnsbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:48:40 INFO - Running setup.py (path:/tmp/pip-y4BmEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:48:40 INFO - Running setup.py (path:/tmp/pip-K0_pDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:48:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:42 INFO - Downloading blessings-1.6.tar.gz 12:48:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:48:42 INFO - Installing collected packages: blessings 12:48:42 INFO - Running setup.py install for blessings 12:48:43 INFO - Successfully installed blessings 12:48:43 INFO - Cleaning up... 12:48:43 INFO - Return code: 0 12:48:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:48:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:48:43 INFO - Reading from file tmpfile_stdout 12:48:43 INFO - Current package versions: 12:48:43 INFO - argparse == 1.2.1 12:48:43 INFO - blessings == 1.6 12:48:43 INFO - blobuploader == 1.2.4 12:48:43 INFO - docopt == 0.6.1 12:48:43 INFO - functools32 == 3.2.3-2 12:48:43 INFO - jsonschema == 2.5.1 12:48:43 INFO - manifestparser == 1.1 12:48:43 INFO - mozInstall == 1.12 12:48:43 INFO - mozcrash == 0.17 12:48:43 INFO - mozdebug == 0.1 12:48:43 INFO - mozdevice == 0.48 12:48:43 INFO - mozfile == 1.2 12:48:43 INFO - mozhttpd == 0.7 12:48:43 INFO - mozinfo == 0.9 12:48:43 INFO - mozleak == 0.1 12:48:43 INFO - mozlog == 3.4 12:48:43 INFO - moznetwork == 0.27 12:48:43 INFO - mozprocess == 0.23 12:48:43 INFO - mozprofile == 0.28 12:48:43 INFO - mozrunner == 6.12 12:48:43 INFO - mozscreenshot == 0.1 12:48:43 INFO - mozsystemmonitor == 0.3 12:48:43 INFO - moztest == 0.7 12:48:43 INFO - mozversion == 1.4 12:48:43 INFO - psutil == 3.1.1 12:48:43 INFO - requests == 1.2.3 12:48:43 INFO - wsgiref == 0.1.2 12:48:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc17a1e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b317b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0790>, '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 0x2bc1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc1b20>, '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': 'db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647', '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 12:48:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:48:43 INFO - Using env: {'DISPLAY': ':0', 12:48:43 INFO - 'HOME': '/home/cltbld', 12:48:43 INFO - 'LANG': 'en_US.UTF-8', 12:48:43 INFO - 'LANGUAGE': 'en_US:en', 12:48:43 INFO - 'LOGNAME': 'cltbld', 12:48:43 INFO - 'MAIL': '/var/mail/cltbld', 12:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:43 INFO - 'MOZ_NO_REMOTE': '1', 12:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:43 INFO - 'NO_EM_RESTART': '1', 12:48:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:43 INFO - 'PWD': '/builds/slave/test', 12:48:43 INFO - 'SHELL': '/bin/bash', 12:48:43 INFO - 'SHLVL': '1', 12:48:43 INFO - 'TERM': 'linux', 12:48:43 INFO - 'TMOUT': '86400', 12:48:43 INFO - 'USER': 'cltbld', 12:48:43 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647', 12:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:43 INFO - '_': '/tools/buildbot/bin/python'} 12:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:48:43 INFO - Cleaning up... 12:48:43 INFO - Return code: 0 12:48:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc17a1e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b317b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0790>, '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 0x2bc1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc1b20>, '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': 'db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647', '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 12:48:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:48:43 INFO - Using env: {'DISPLAY': ':0', 12:48:43 INFO - 'HOME': '/home/cltbld', 12:48:43 INFO - 'LANG': 'en_US.UTF-8', 12:48:43 INFO - 'LANGUAGE': 'en_US:en', 12:48:43 INFO - 'LOGNAME': 'cltbld', 12:48:43 INFO - 'MAIL': '/var/mail/cltbld', 12:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:43 INFO - 'MOZ_NO_REMOTE': '1', 12:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:43 INFO - 'NO_EM_RESTART': '1', 12:48:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:43 INFO - 'PWD': '/builds/slave/test', 12:48:43 INFO - 'SHELL': '/bin/bash', 12:48:43 INFO - 'SHLVL': '1', 12:48:43 INFO - 'TERM': 'linux', 12:48:43 INFO - 'TMOUT': '86400', 12:48:43 INFO - 'USER': 'cltbld', 12:48:43 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647', 12:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:43 INFO - '_': '/tools/buildbot/bin/python'} 12:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:48:43 INFO - Cleaning up... 12:48:43 INFO - Return code: 0 12:48:43 INFO - Running post-action listener: _resource_record_post_action 12:48:43 INFO - Running post-action listener: _start_resource_monitoring 12:48:43 INFO - Starting resource monitoring. 12:48:43 INFO - [mozharness: 2016-10-06 19:48:43.818959Z] Finished create-virtualenv step (success) 12:48:43 INFO - [mozharness: 2016-10-06 19:48:43.819467Z] Running install step. 12:48:43 INFO - Running pre-action listener: _resource_record_pre_action 12:48:43 INFO - Running main action method: install 12:48:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:48:44 INFO - Reading from file tmpfile_stdout 12:48:44 INFO - Detecting whether we're running mozinstall >=1.0... 12:48:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:48:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:48:44 INFO - Reading from file tmpfile_stdout 12:48:44 INFO - Output received: 12:48:44 INFO - Usage: mozinstall [options] installer 12:48:44 INFO - Options: 12:48:44 INFO - -h, --help show this help message and exit 12:48:44 INFO - -d DEST, --destination=DEST 12:48:44 INFO - Directory to install application into. [default: 12:48:44 INFO - "/builds/slave/test"] 12:48:44 INFO - --app=APP Application being installed. [default: firefox] 12:48:44 INFO - mkdir: /builds/slave/test/build/application 12:48:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:48:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:49:01 INFO - Reading from file tmpfile_stdout 12:49:01 INFO - Output received: 12:49:01 INFO - /builds/slave/test/build/application/firefox/firefox 12:49:01 INFO - Running post-action listener: _resource_record_post_action 12:49:01 INFO - [mozharness: 2016-10-06 19:49:01.128215Z] Finished install step (success) 12:49:01 INFO - [mozharness: 2016-10-06 19:49:01.128492Z] Running run-tests step. 12:49:01 INFO - Running pre-action listener: _resource_record_pre_action 12:49:01 INFO - Running main action method: run_tests 12:49:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:49:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:49:01 INFO - Python 2.7.3 12:49:01 INFO - Return code: 0 12:49:01 INFO - grabbing minidump binary from tooltool 12:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:49:01 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0790>, '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 0x2bc1690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:49:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:49:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:49:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:49:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:49:01 INFO - Return code: 0 12:49:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:49:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:49:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:49:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:49:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:49:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:49:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:49:01 INFO - Using env: {'DISPLAY': ':0', 12:49:01 INFO - 'HOME': '/home/cltbld', 12:49:01 INFO - 'LANG': 'en_US.UTF-8', 12:49:01 INFO - 'LANGUAGE': 'en_US:en', 12:49:01 INFO - 'LOGNAME': 'cltbld', 12:49:01 INFO - 'MAIL': '/var/mail/cltbld', 12:49:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:49:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:01 INFO - 'MOZ_NO_REMOTE': '1', 12:49:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:01 INFO - 'NO_EM_RESTART': '1', 12:49:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:01 INFO - 'PWD': '/builds/slave/test', 12:49:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:49:01 INFO - 'SHELL': '/bin/bash', 12:49:01 INFO - 'SHLVL': '1', 12:49:01 INFO - 'TERM': 'linux', 12:49:01 INFO - 'TMOUT': '86400', 12:49:01 INFO - 'USER': 'cltbld', 12:49:01 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647', 12:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:01 INFO - '_': '/tools/buildbot/bin/python'} 12:49:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:49:01 INFO - mozversion application_buildid: 20161006093044 12:49:01 INFO - mozversion application_changeset: 9d162f236562f4ff038e095ce1af5d31eb578f52 12:49:01 INFO - mozversion application_display_name: Nightly 12:49:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:49:01 INFO - mozversion application_name: Firefox 12:49:01 INFO - mozversion application_remotingname: firefox 12:49:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:49:01 INFO - mozversion application_vendor: Mozilla 12:49:01 INFO - mozversion application_version: 52.0a1 12:49:01 INFO - mozversion platform_buildid: 20161006093044 12:49:01 INFO - mozversion platform_changeset: 9d162f236562f4ff038e095ce1af5d31eb578f52 12:49:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:49:01 INFO - mozversion platform_version: 52.0a1 12:49:01 INFO - using testdate: 1475783341 12:49:01 INFO - actual date: 1475783341 12:49:01 INFO - starting webserver on 'localhost:48876' 12:49:01 INFO - SUITE-START | Running 2 tests 12:49:01 INFO - TEST-START | dromaeo_css 12:49:01 INFO - operating with platform_type : linux_ 12:49:01 INFO - Initialising browser for dromaeo_css test... 12:49:01 INFO - TEST-INFO | started process 25587 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE4dtry/profile http://localhost:48876/getInfo.html) 12:49:06 INFO - PROCESS | 25587 | __metrics Screen width/height:1600/1200 12:49:06 INFO - PROCESS | 25587 | colorDepth:24 12:49:06 INFO - PROCESS | 25587 | Browser inner width/height: 1024/697 12:49:06 INFO - PROCESS | 25587 | __metrics 12:49:06 ERROR - PROCESS | 25587 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 12:49:07 INFO - TEST-INFO | 25587: exit 0 12:49:07 INFO - Browser initialized. 12:49:07 INFO - Running cycle 1/1 for dromaeo_css test... 12:49:07 INFO - TEST-INFO | started process 25707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE4dtry/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:49:19 INFO - PROCESS | 25707 | RSS: Main: 184872960 12:49:19 INFO - PROCESS | 25707 | 12:50:09 INFO - PROCESS | 25707 | 1475783409358 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] 12:52:19 INFO - PROCESS | 25707 | Cycle 1(1): loaded http://localhost:48876/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48876/tests/dromaeo/cssquery-ext.html) 12:52:20 INFO - PROCESS | 25707 | RSS: Main: 201961472 12:52:20 INFO - PROCESS | 25707 | 12:55:23 INFO - PROCESS | 25707 | Cycle 1(1): loaded http://localhost:48876/tests/dromaeo/cssquery-ext.html (next: http://localhost:48876/tests/dromaeo/cssquery-jquery.html) 12:55:23 INFO - PROCESS | 25707 | RSS: Main: 201981952 12:55:23 INFO - PROCESS | 25707 | 12:58:25 INFO - PROCESS | 25707 | Cycle 1(1): loaded http://localhost:48876/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48876/tests/dromaeo/cssquery-mootools.html) 12:58:26 INFO - PROCESS | 25707 | RSS: Main: 198569984 12:58:26 INFO - PROCESS | 25707 | 13:01:28 INFO - PROCESS | 25707 | Cycle 1(1): loaded http://localhost:48876/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48876/tests/dromaeo/cssquery-prototype.html) 13:01:28 INFO - PROCESS | 25707 | RSS: Main: 195182592 13:01:28 INFO - PROCESS | 25707 | 13:04:31 INFO - PROCESS | 25707 | Cycle 1(1): loaded http://localhost:48876/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48876/tests/dromaeo/cssquery-yui.html) 13:04:32 INFO - PROCESS | 25707 | RSS: Main: 198717440 13:04:32 INFO - PROCESS | 25707 | 13:07:34 INFO - PROCESS | 25707 | Cycle 1(1): loaded http://localhost:48876/tests/dromaeo/cssquery-yui.html (next: http://localhost:48876/tests/dromaeo/cssquery-dojo.html) 13:07:34 INFO - PROCESS | 25707 | RSS: Main: 198930432 13:07:34 INFO - PROCESS | 25707 | 13:07:34 INFO - PROCESS | 25707 | __start_tp_report 13:07:34 INFO - PROCESS | 25707 | _x_x_mozilla_page_load 13:07:34 INFO - PROCESS | 25707 | _x_x_mozilla_page_load_details 13:07:34 INFO - PROCESS | 25707 | |i|pagename|runs| 13:07:34 INFO - PROCESS | 25707 | |0;dojo.html;3011.894583689571;3045.573619693242;3073.3853229354136;3076.3847230553893;3088.6139232595924;5155.793768249266;5239.5546378557865;5301.6818990860575;5302.996461029128;5360;5206.531412172903;5278.287431196787;5290.788368465266;5292.1003429417;5324.787008519665;4771.785269662856;4834.637402194832;4848.296996935443;4875.24433712775;4894.290327902452;4883.19427294496;4894.094592500381;4923.507649235084;4933.309336692848;4964.0816448956875;4676.415448068991;4708.152532544141;4861.854144375674;4867;4930.063287975291;4754.286856971447;4788.832390866338;4809.302651115604;4821.373221481185;4891.633127515415;4772.42730872294;4777.689450185761;4786.282057691339;4789.042191561667;4849.684770489942;5044.672096313728;5254.605904557136;5314.256004159421;5336.226247194174;5351.09031464652;5389.8113566025395;5478.315210598676;5513.173024046385;5567.192757050205;5666.716664166816;5617.157426386034;5622.606417550773;5631.7465714042555;5633.126865335879;5654.7842213924205;5239.187925871496;5239.633225674204;5250.369955605313;5289.920651190235;5298.993191293642;5611.130274807329;5650.604457687922;5718.51392631631;5793.391693872167;5804.100364443518;5583.832485025456;5592.720363981784;5600.187972743929;5609.27079479665;5665.178549110356;5480.205370221295;5595.21666966625;5687.459691329317;5689.48794608479;5698.7435565399655;5475.507204351547;5580.972095139579;5640.182173584807;5648.74580643872;5745.85635359111;5647.265855438849;5688.146777983336;5692.316921969307;5698.031334673115;5704.34400043992;4364.956350436519;4371.737695738266;4379;4388.5830846069575;4442.666799990014;3817.1602247505502;3818.0645741792882;3830.9808450958126;3836.712246581462;3881.514810648669;5289.867753306121;5319.388270348882;5324.068288049576;5331.306930099062;5401.945980540144;5589.552835773128;5593.468620481048;5612.607117501736;5618.719064046863;5637.408072152365;5182.222666600041;5221.295125158055;5245.344331958505;5273.050850846885;5333.599980001515;4804.231322988305;4812.35033270511;4821.710697358169;4857.247126695368;4872.8781780455065;5682.431756824284;5691.90833784172;5699.430056994351;5719.885602287848;5767.769289228384;5537.889242215214;5555.777768889199;5601.663900166003;5603.299587551556;5614.466625670555;5696.829095127153;5741.1388291756575;5754.079347304411;5821.301443826598;5822;5549.667019978653;5575.080111781511;5585.609007369445;5588.608797384144;5591.217229587943;5452.645578037414;5502.559795216293;5694.202811606461;5707.543396528351;5724.341700704305;5400.243965844864;5450.890982180414;5455.618106732491;5459.672419654833;5459.890802184013;5439.238506609157;5449.863753406196;5460.180972854104;5460.290162278879;5460.453954604508;5318.042752304622;5385.703786291791;5414.404415514369;5421.701806400686;5423.3491980962535;5479.0411677957;5497.972510137423;5506.421825708243;5507.586930980113;5533.253010843646;5358.437364076872;5397.514223719884;5403.0544654686055;5407.188921661625;5468.91796623059 13:07:34 INFO - PROCESS | 25707 | |1;ext.html;568.5054003017375;577.4196932083257;590.8995470769971;595.8510372406898;596.8090211132437;41094.38358424626;42727.30908436484;42771.57228427715;46952.530474695246;46959.76520117403;45428.545714542845;45535.54464455354;45713.7714311428;45791;45968.3104753429;8742.650293988232;8857.247133993618;8880.24517915978;8898.555072246394;8913.68802091927;8832.779180520474;8899.199072083511;8903.688370907019;8903.688370907019;8920.197182253596;8835.425697329685;8902.688405905794;8929.374943753939;8973.685920992766;8987;8890.199882010618;8901.554922253861;8917.910820891773;8929.642814287421;8950.149735775123;8727.912720872773;8817.515036672981;8849.292056635519;8855.07021762712;8889.111088891059;41443.585564144276;41989.58010419918;42064.36903446451;42136.57863421388;42231;3424.9486257706153;3483.5645544306963;3844.8269827857534;3891.9610803891883;3924.607539246081;30490;30568.694313056807;30604.846975765202;30883.84558077195;31597.526037109234;4198.809677067943;4314.956850431518;4380.430544029287;4438.933415998763;4503.684742068057;341100;344933;346501.2674936634;347014;347122;53214;53575.19637205445;53602.19596706053;53630;53636.46363536393;57682;57698.4230157693;57769.4223057764;57791.711041445364;57840;15452.690946181014;15621.765673514907;15646.139462329453;15647.061176329456;15659.217039147998;12441.75116497665;12664.556740514037;12670.049746269067;12701.809472857729;12702.142018045866;13430;15346;15347.23263836826;15446.5366039019;15620;5650.74571644277;5730.971345143247;5772.595918285764;5821.505172060422;5916.822495325147;945.2768631996528;986.9506524673737;1031.7162780235344;1049.6116436918237;1092.3118435385657;31246.375072498424;31343.68656313453;31372.215694607818;31464.213394664857;31759.52360714591;1072.254782925859;1089.7548051688466;1116.5812820192427;1135.920485566019;1219.536576101076;16748.330066797436;17338.479845604652;17410.303587856342;17940.641187176185;18386.26454941814;561666;562655;564636;565930;567724;55648;56530.43469565334;56552.71723641438;56572.717136414874;56858;1289.6775806048488;1310.3579246169309;1364.7202323523654;1367.7469668111232;1383.280694039094;28619;30589.847050764605;31113.844430777703;31419.528707068956;32168.517472238404;47583.28625070696;48991.26513102378;49007;49058.264126038855;49059.5094049055;440088;441368;442076;442830;443095;25067;25638;25764.484710305314;25845.870770646026;27177.45645087127;44760.55239447694;44765.552344476135;45699;46281.53718462772;46871;38277.80861095677;38841.6115838838;38912.33052033774;40459.19081618292;40784.3882341771;38762.28663993494;38842.41736374013;39052.41421378625;39966.600333996284;40642.59357406388;38741.6125838738;39457.40813887736;39629.40555891721;39759.204815902944;39872.40191397073;32945.835270823496;34679.8620482829;35022.47466287957;35964.28071438609;36113.63886361103;27043.053493127645;27075.45849082968;27204.863975679997;27272.727272727814;27322.590161147997 13:07:34 INFO - PROCESS | 25707 | |2;jquery.html;389.75640224859444;391.23318296139564;398.930187217237;399.73817149766904;422.47570764681035;14402.927985360086;18219.635607287863;18934.011928747488;19904.70142947855;19921.701174482376;18333.908330458362;18580.349687760932;19345.22619095238;19626.705599415985;19682.311119110833;5619.775208991636;5624.578156638258;5788.5369170466265;5842.591018628697;5849.649021058729;5718.399568045358;5764.423557644244;5791.7972870949525;5793.913091303612;5805.477507024367;5592.105263157896;5694.117411801178;5785.537157027427;5787.623804452718;5798.101294299369;5579.553635709133;5720.599558030939;5776.162456443834;5788.594798364116;5810.854728631797;5613.971930140323;5746.597738158289;5757.107648314518;5759.308882934033;5779.653220806765;13050.2822344771;14481.710365792731;22145.44636384087;22910;23048.308550743506;2186.30038387716;2210.1380461619983;2246.2475070851283;2248.910043598254;2447.681801365811;9351.579178936965;9626.51867406634;9678.95160524193;9775.755606109833;10156.695299141038;1893.2616279650947;1901.6291823094502;1913.1486488512617;1924.441911845563;1953.9511512212166;75339.62330188314;81628.9999999994;83238;83623;85757.57121214416;10067.194624430029;10158.644447444452;10405.635802746867;10424.895751042544;10538.894611053945;13480.191188528719;14075.788863167061;14119.788203176755;14123.929380353238;14341.354639041268;7506.587137707369;7650.885236721454;7869.409794265453;7912.169222231698;8120.279706298338;7389.519681220703;7420.295071968154;7438.4049276057785;7616.35261002821;7727.150013498511;4680.9297860532115;4704.482506924304;4760.33355330254;4776.2119250324;4809.95190048102;1946.698261769428;1996.6106609211065;1997.7902320256455;1999.4701404127918;2062.824659903895;866.9479831210148;883.1698203688512;914.7895983923735;1012.0284526854156;1053.9683809485728;17881.37415190462;19321.130549125322;19327.613447730968;19382.903085484482;19833.611647184847;983.2036050798876;988.5897352598735;994.9801003979879;1011.9949400252951;1037.5019990404649;10217.642382516726;10998.395088270221;11069.446527673585;11078.501467433985;11106.222564420576;406921;407132;434946;436965;440070;88864.5556772212;91389;91718.54140729387;92203.53898230466;92561;988.8763904511936;988.960441582343;995.6850322999056;1027.7430642339416;1032;16305.59236019109;16739.581510462336;17025;18479.168437420616;18822.341218057303;30944.381112378076;35997.46003809893;41146.1770764589;45045.54954450414;45311.555051306146;52135;52630.73684631552;53352.733236333566;61675.383246168756;63053.684731576046;8083.232092951161;8103.716369927024;8189.181081891763;8267.255946964802;8411.45325553837;11397.544098235978;13127;13234.139780914209;13375.732485350043;13413.731725365244;10629.468526573795;11199.104071674083;11245.269057511236;11442.885571144181;11794.05647548177;10145.64490242838;10739.677809665722;10851.077658399125;10889.509972051435;11311.151663625096;11743.941280293544;11849.407529623311;11877.881221187678;11879.940600296943;12217.266963982189;8263.256306932404;8273.172682731678;8290.502569845828;8315.376346773895;8692.391532592657;9211.539423028687;10571.418571978615;10871.891281087088;11027;11054.336739795637 13:07:34 INFO - PROCESS | 25707 | |3;mootools.html;1422.900396972212;1461.6126726417494;1646.4648989078553;1797.4338083503687;1811.0401487211775;8319.66721331146;8610.52642104684;8968.372213945026;9702.320837541374;9711.514424278794;8624.310055195585;8956.373053886215;9012.233960113383;9249.676261330855;9313.16181543661;2313.4332088638266;2339.63735620979;2347.9060837566476;2349.1777877742825;2350.788429041386;2277.407873952776;2278.7037685100913;2331.4870728439714;2334.953300933989;2338.53229354129;2334.8832558372096;2342.906283748648;2356.964645530318;2367.4673198530277;2374.6556749271344;2199.417154454071;2210.7568167501563;2216.2797090945505;2218.744844342889;2220.123051394698;2270.3302525754943;2271;2274.715660542432;2290.5075408787025;2295.426143464134;9312.208462280714;9478.099580539838;9493.193078588329;9502.287328450393;9533.427994320364;5221.347331583552;5345.850642111965;5370.167624018283;5375.596830237748;5389.541888939445;3312.029342541184;3352.2625022495013;3482.547268855058;3520.6655367740022;3526.523919270917;1267.2206592945365;1273.197885332244;1290.6837824733;1294.8122522234223;2114.143771772435;12994.090413671047;13390.732185356239;13508.459661613524;13529.255890925995;13608.931955340258;4259.531451540328;4493.662975276802;4587.243104887656;4591.517890621503;4594.33382159585;10430.426326552113;10439.164866810637;10471.371717696962;10489.842652360221;10500;5296.285001524745;5332.200169974457;5341.545968592635;5355.625106242604;5357;4486.5962063414445;4740.644451666139;4806.303086052572;4830.033993201374;4972.080165169383;3796.4115562087923;3914.8825535233987;3946.8421263149726;3972.6027397260623;3981.5421226558738;1170.1633332167542;1194.778965891313;1198.6344165029575;1206.4256145729908;1207.5109580619862;952.3238500664468;987.7283746969497;1001.689476262361;1006.0492834271689;1008.6721815410021;5853.443922827325;5974;5983.670898100646;6175.59858609189;6274.435300822948;447.1593404399708;454.7953420960581;455.60362484637915;458.3331253026838;461.35180071998224;4076.490438695163;4280.871573852789;4295.162443323522;4455.309427038814;4489.124620698998;11719.414029298501;12031.518739250332;12051.397430128458;12129.514819407124;12134;10940.781184376268;11615.186936914504;11734.002609778094;12142.210756300989;12142.635720928387;8610.526421046903;8631;8749.387542871938;8799.516026618598;8971.955140224387;6288.402601752826;6423.96788016057;6547.541672082908;6604.174478190226;6629.237637671729;10462.47687615601;10873.238873279111;10909;11097.556097756;11122.833157502482;11006.449677516252;11158.776824463628;11172.273802202832;11176.658800943938;11242.100631949588;8042.919570804451;8146.83706325882;8352.665893364197;8479.15208479147;8486.660533578835;9281.953590232275;9351.345405821527;9412.623495060121;9421.764455888657;9443.669471568463;7954.164812694815;7994;8059;8321.209485098905;8539.74380768578;8067.171714659509;8213.95893020531;8235.876461852957;8267.751967440987;8557.48655080697;6835.21395039557;7271.127464704058;7348;7371.631418429164;7372.63136843145;5190.455002224712;5319.920201197063;5411.3224900279465;5462.617616766788;5487.890242195054;5365.865853353541;5407.567394608343;5438.918416223839;5505.284313039279;5629.718514074198 13:07:34 INFO - PROCESS | 25707 | |4;prototype.html;321.54661926683366;323.4210762734705;330.92779394760964;337.81251405469953;348.34163431115184;5346.91979620306;5403.864903377417;5412.161115027167;5423.972880135599;5475.78096876125;5319.973400133003;5322.973385133078;5333.2000199970025;5340.49265319794;5372.758225879835;4224.324108142698;4231.645873320531;4246.341817018367;4256.680429066983;4261.21167583998;3782.3948168293077;4078.7348822326453;4101.671866250693;4184.707070505051;4253.1493701259715;4195.874073815012;4200.726952748061;4213.346931225665;4227.87316380509;4242.596953289448;4246.3205887058075;4261.169072030955;4270.252705776507;4272.722273052242;4274.465691788527;3463.930721385583;3766.2844059628583;3795.734298599099;3796.9430458543143;3800.9094997751404;5222.92165617516;5225.99505284463;5253.317068781034;5281.151596941078;5286.762095705664;4714;4721.905561888743;4729.628407761779;4731.621470282369;4744.098621261984;5470.64440811346;5583.274174357308;5592;5603.215549823028;5637.154426835967;3979.4428779970826;3979.5025621797276;3987.8205480753436;3999.24014437256;4014.45804816349;5539.806106786243;5682.346530149044;5794.82615521535;5794.88410231793;5797.565182611321;3991.8004099794894;4068.613481719232;4069.654079403225;4072.429859819628;4076.7146299758733;4142.668586513072;4146.564610715832;4147;4156.334986402161;4166.645835103989;4705.635365743896;4782.880427989328;4787.760611969387;4796.544328288807;4819.132556139928;5620.5503559715125;5685.431456854281;5698.751711524391;5710.600257981984;5720.914186287126;1432.5630682641895;1439.2659743530664;1442.7159827753308;1442.809682012323;1443.3617843747213;864.2308345572445;909.1681111782777;926.1895841139003;946.4888959961544;951.2247518272724;4767;4778.737169455644;4824.758762061883;4827.9825109306685;4842.806287748521;5068.315777370081;5074.2895994560795;5100.948990510122;5120.61595380348;5121.334226550524;4510.691899349152;4756.6908150970075;4772.308015337757;4802.807887684523;4827.562081149067;2653.150991682643;2681.8927242910063;2688.637034000385;2695.9056433025144;2708.5937109433744;5101.387833460009;5134.614903882224;5157.249666621689;5168.586513078944;5184.870378240575;5130.256112863689;5161.4322424533275;5164.535191832678;5585.4865310610385;6030.909536356959;5922.733476993546;5945.40545945402;5947.31605865331;5955.612885162451;5970.552208584373;5870.236869207147;5881.911771323348;5890.352061273171;5908.615939963888;5936.22829032223;5563.805266815642;5808;5827.3007239131575;5828.44629760189;5849.94150058511;5764.279465066867;5926.585139040226;5941.7623295067715;5949.3753155918;5976.820695378971;4187.576224083826;4238.1523695261685;4266.5093514246255;4267.5305716371795;4270.654743755707;5727.226824378656;5864.296284445893;5885.970570147293;5922.9338719029265;5923.970380148244;5690.459406356389;5706.543476521952;5731.426857314235;5771.018926782541;5776.537876969916;5697.857553561194;5708.974243650871;5754.8849023018465;5775.653460792366;5806.883862322646;5552.278203833475;5730.312362516524;5744.454276843693;5755.36690964002;5792.7103644818435;5778.971105144616;5786.218860453785;5786.334571524329;5789.942100579109;5823.126531020381;5634.661920284796;5672.149177623224;5678.290213723285;5706.058500347396;5715.31416230055 13:07:34 INFO - PROCESS | 25707 | |5;yui.html;655.6459511863593;686.2896901706735;698.87070891885;702.2731472925523;726.6439444672109;15406.92296538517;16714.331426742916;16784.328626854927;16886.324547018103;16887.24007419666;14374.281285935715;14481.420743170287;14641.19473428961;15171.9379643425;15255.6948861023;786.5162924801249;797.6490344248541;804.155636581587;805.3235282362814;808.0949336742827;796.2037962037962;799.856025915335;800.403699244061;801.8636831738589;803.6664784114614;693.2409012131708;712.6329940080863;839.5214727605268;840.3487297344545;844.3498506150261;802.4904185842004;822.5681517203457;823.4606332851962;828.5360198288978;830.4394533689735;596.1236981636987;597.5667640960312;597.8505373656586;597.8684689368332;604.0064094564461;14712.705745885129;14762.188079655614;14786.260686965608;14790.630234244123;14863.777043344358;13729.862701373058;13823.447062117502;13895.652608684763;14008;14082.436702531886;12307.44616492251;12416.937915310365;12706.237625742486;12817.23096614206;12836.422360993778;4183.267928112598;4270.466191726035;4327.7619730914785;4354.7604881731495;4368.694191406603;76208;76432.23567764307;77573.61213193955;77791.61104194443;78199.60900195462;10628.574857005788;11012;11095.334279943228;11141.16441266892;11545.595904143483;21420.03609837561;21437.785622143892;21468.677969830464;21829.12683492674;21873.562528749335;7749.651265693057;7944.205579442125;7982.481138725964;8131.390145739093;8151.103378628346;4365.214261432972;4387.583179597933;4428.55714428561;4537.274036154266;4544.522825103382;3454.6199918008997;3592.2456284180616;3597.172650290448;3609.0255630979486;3609.9278014439565;587.8354060862965;595.4849055566904;602.5179856115091;606.9028955367208;618.8081694674665;582.8542864283929;604.9213602231682;617.3332800575367;632.3265722006141;647.0494544875384;8299.709510167115;8569.914300856912;8830.55847207637;9067.637294508146;9119.498427586546;587.7413937867325;588.7703795519751;609.7621827689796;621.5680102328838;641.8523739539838;3981.7013723970817;4289.313709806478;4378.365137055172;4433.401490798766;4462.286034234507;61133.69433152806;71746;117448.41275793737;125806.67739903269;125820;84616.57691711502;101602;102470.48764756278;104480.47759761305;104966;50984.49015509798;51864;74948.25051749522;79411.60294198492;85484.57257713797;8182.4681395709085;8692.261157801659;8961.865572016295;9094.181523662903;9114;48994.755026224644;49711.502884972135;50425.49574504208;50995.49004510056;52266.47733522616;63068.68465657642;71054;71853.28146718466;72295;74153.6292318535;10897.564097436014;11231.887681123411;11364.318140911571;12613.810792838298;12815.871841281842;13692.863071369158;13799.448022079407;13968.37142328618;14549.030963245787;14600.196989165697;12460.688482788002;12514.43685034194;12749.426275817425;12999.935000324938;14013.29933503341;13630.591082267549;13720.588382348546;13770.242636654679;14000.509982150576;14221.288935552973;13025.352901187682;13034.934825325812;13719.862801372257;14075.507357242448;14088.295585220903;10603.138402042627;10651.627193048205;10715.946420267848;10748.247622666651;10960.177986651193;8324.62539185726;10124;10434.530446130095;10712.62505812324;11196.328220306808 13:07:34 INFO - PROCESS | 25707 | __end_tp_report 13:07:34 INFO - PROCESS | 25707 | __start_cc_report 13:07:34 INFO - PROCESS | 25707 | _x_x_mozilla_cycle_collect,305 13:07:34 INFO - PROCESS | 25707 | __end_cc_report 13:07:34 INFO - PROCESS | 25707 | __startTimestamp1475784454916__endTimestamp 13:07:34 INFO - PROCESS | 25707 | 13:07:34 INFO - PROCESS | 25707 | ------- Summary: start ------- 13:07:34 INFO - PROCESS | 25707 | Number of tests: 6 13:07:34 INFO - PROCESS | 25707 | 13:07:34 INFO - PROCESS | 25707 | [#0] dojo.html Cycles:165 Average:5225.60 Median:5407.19 stddev:575.13 (10.6%) stddev-sans-first:550.05 13:07:34 INFO - PROCESS | 25707 | Values: 3011.9 3045.6 3073.4 3076.4 3088.6 5155.8 5239.6 5301.7 5303.0 5360.0 5206.5 5278.3 5290.8 5292.1 5324.8 4771.8 4834.6 4848.3 4875.2 4894.3 4883.2 4894.1 4923.5 4933.3 4964.1 4676.4 4708.2 4861.9 4867.0 4930.1 4754.3 4788.8 4809.3 4821.4 4891.6 4772.4 4777.7 4786.3 4789.0 4849.7 5044.7 5254.6 5314.3 5336.2 5351.1 5389.8 5478.3 5513.2 5567.2 5666.7 5617.2 5622.6 5631.7 5633.1 5654.8 5239.2 5239.6 5250.4 5289.9 5299.0 5611.1 5650.6 5718.5 5793.4 5804.1 5583.8 5592.7 5600.2 5609.3 5665.2 5480.2 5595.2 5687.5 5689.5 5698.7 5475.5 5581.0 5640.2 5648.7 5745.9 5647.3 5688.1 5692.3 5698.0 5704.3 4365.0 4371.7 4379.0 4388.6 4442.7 3817.2 3818.1 3831.0 3836.7 3881.5 5289.9 5319.4 5324.1 5331.3 5401.9 5589.6 5593.5 5612.6 5618.7 5637.4 5182.2 5221.3 5245.3 5273.1 5333.6 4804.2 4812.4 4821.7 4857.2 4872.9 5682.4 5691.9 5699.4 5719.9 5767.8 5537.9 5555.8 5601.7 5603.3 5614.5 5696.8 5741.1 5754.1 5821.3 5822.0 5549.7 5575.1 5585.6 5588.6 5591.2 5452.6 5502.6 5694.2 5707.5 5724.3 5400.2 5450.9 5455.6 5459.7 5459.9 5439.2 5449.9 5460.2 5460.3 5460.5 5318.0 5385.7 5414.4 5421.7 5423.3 5479.0 5498.0 5506.4 5507.6 5533.3 5358.4 5397.5 5403.1 5407.2 5468.9 13:07:34 INFO - PROCESS | 25707 | 13:07:34 INFO - PROCESS | 25707 | [#1] ext.html Cycles:180 Average:60231.22 Median:23094.19 stddev:122116.76 (528.8%) stddev-sans-first:122377.16 13:07:34 INFO - PROCESS | 25707 | Values: 568.5 577.4 590.9 595.9 596.8 41094.4 42727.3 42771.6 46952.5 46959.8 45428.5 45535.5 45713.8 45791.0 45968.3 8742.7 8857.2 8880.2 8898.6 8913.7 8832.8 8899.2 8903.7 8903.7 8920.2 8835.4 8902.7 8929.4 8973.7 8987.0 8890.2 8901.6 8917.9 8929.6 8950.1 8727.9 8817.5 8849.3 8855.1 8889.1 41443.6 41989.6 42064.4 42136.6 42231.0 3424.9 3483.6 3844.8 3892.0 3924.6 30490.0 30568.7 30604.8 30883.8 31597.5 4198.8 4315.0 4380.4 4438.9 4503.7 341100.0 344933.0 346501.3 347014.0 347122.0 53214.0 53575.2 53602.2 53630.0 53636.5 57682.0 57698.4 57769.4 57791.7 57840.0 15452.7 15621.8 15646.1 15647.1 15659.2 12441.8 12664.6 12670.0 12701.8 12702.1 13430.0 15346.0 15347.2 15446.5 15620.0 5650.7 5731.0 5772.6 5821.5 5916.8 945.3 987.0 1031.7 1049.6 1092.3 31246.4 31343.7 31372.2 31464.2 31759.5 1072.3 1089.8 1116.6 1135.9 1219.5 16748.3 17338.5 17410.3 17940.6 18386.3 561666.0 562655.0 564636.0 565930.0 567724.0 55648.0 56530.4 56552.7 56572.7 56858.0 1289.7 1310.4 1364.7 1367.7 1383.3 28619.0 30589.8 31113.8 31419.5 32168.5 47583.3 48991.3 49007.0 49058.3 49059.5 440088.0 441368.0 442076.0 442830.0 443095.0 25067.0 25638.0 25764.5 25845.9 27177.5 44760.6 44765.6 45699.0 46281.5 46871.0 38277.8 38841.6 38912.3 40459.2 40784.4 38762.3 38842.4 39052.4 39966.6 40642.6 38741.6 39457.4 39629.4 39759.2 39872.4 32945.8 34679.9 35022.5 35964.3 36113.6 27043.1 27075.5 27204.9 27272.7 27322.6 13:07:34 INFO - PROCESS | 25707 | 13:07:34 INFO - PROCESS | 25707 | [#2] jquery.html Cycles:180 Average:26810.14 Median:399.33 stddev:70601.46 (17679.8%) stddev-sans-first:70771.64 13:07:34 INFO - PROCESS | 25707 | Values: 389.8 391.2 398.9 399.7 422.5 14402.9 18219.6 18934.0 19904.7 19921.7 18333.9 18580.3 19345.2 19626.7 19682.3 5619.8 5624.6 5788.5 5842.6 5849.6 5718.4 5764.4 5791.8 5793.9 5805.5 5592.1 5694.1 5785.5 5787.6 5798.1 5579.6 5720.6 5776.2 5788.6 5810.9 5614.0 5746.6 5757.1 5759.3 5779.7 13050.3 14481.7 22145.4 22910.0 23048.3 2186.3 2210.1 2246.2 2248.9 2447.7 9351.6 9626.5 9679.0 9775.8 10156.7 1893.3 1901.6 1913.1 1924.4 1954.0 75339.6 81629.0 83238.0 83623.0 85757.6 10067.2 10158.6 10405.6 10424.9 10538.9 13480.2 14075.8 14119.8 14123.9 14341.4 7506.6 7650.9 7869.4 7912.2 8120.3 7389.5 7420.3 7438.4 7616.4 7727.2 4680.9 4704.5 4760.3 4776.2 4810.0 1946.7 1996.6 1997.8 1999.5 2062.8 866.9 883.2 914.8 1012.0 1054.0 17881.4 19321.1 19327.6 19382.9 19833.6 983.2 988.6 995.0 1012.0 1037.5 10217.6 10998.4 11069.4 11078.5 11106.2 406921.0 407132.0 434946.0 436965.0 440070.0 88864.6 91389.0 91718.5 92203.5 92561.0 988.9 989.0 995.7 1027.7 1032.0 16305.6 16739.6 17025.0 18479.2 18822.3 30944.4 35997.5 41146.2 45045.5 45311.6 52135.0 52630.7 53352.7 61675.4 63053.7 8083.2 8103.7 8189.2 8267.3 8411.5 11397.5 13127.0 13234.1 13375.7 13413.7 10629.5 11199.1 11245.3 11442.9 11794.1 10145.6 10739.7 10851.1 10889.5 11311.2 11743.9 11849.4 11877.9 11879.9 12217.3 8263.3 8273.2 8290.5 8315.4 8692.4 9211.5 10571.4 10871.9 11027.0 11054.3 13:07:34 INFO - PROCESS | 25707 | 13:07:34 INFO - PROCESS | 25707 | [#3] mootools.html Cycles:180 Average:6099.02 Median:4491.39 stddev:3614.25 (80.5%) stddev-sans-first:3607.30 13:07:34 INFO - PROCESS | 25707 | Values: 1422.9 1461.6 1646.5 1797.4 1811.0 8319.7 8610.5 8968.4 9702.3 9711.5 8624.3 8956.4 9012.2 9249.7 9313.2 2313.4 2339.6 2347.9 2349.2 2350.8 2277.4 2278.7 2331.5 2335.0 2338.5 2334.9 2342.9 2357.0 2367.5 2374.7 2199.4 2210.8 2216.3 2218.7 2220.1 2270.3 2271.0 2274.7 2290.5 2295.4 9312.2 9478.1 9493.2 9502.3 9533.4 5221.3 5345.9 5370.2 5375.6 5389.5 3312.0 3352.3 3482.5 3520.7 3526.5 1267.2 1273.2 1290.7 1294.8 2114.1 12994.1 13390.7 13508.5 13529.3 13608.9 4259.5 4493.7 4587.2 4591.5 4594.3 10430.4 10439.2 10471.4 10489.8 10500.0 5296.3 5332.2 5341.5 5355.6 5357.0 4486.6 4740.6 4806.3 4830.0 4972.1 3796.4 3914.9 3946.8 3972.6 3981.5 1170.2 1194.8 1198.6 1206.4 1207.5 952.3 987.7 1001.7 1006.0 1008.7 5853.4 5974.0 5983.7 6175.6 6274.4 447.2 454.8 455.6 458.3 461.4 4076.5 4280.9 4295.2 4455.3 4489.1 11719.4 12031.5 12051.4 12129.5 12134.0 10940.8 11615.2 11734.0 12142.2 12142.6 8610.5 8631.0 8749.4 8799.5 8972.0 6288.4 6424.0 6547.5 6604.2 6629.2 10462.5 10873.2 10909.0 11097.6 11122.8 11006.4 11158.8 11172.3 11176.7 11242.1 8042.9 8146.8 8352.7 8479.2 8486.7 9282.0 9351.3 9412.6 9421.8 9443.7 7954.2 7994.0 8059.0 8321.2 8539.7 8067.2 8214.0 8235.9 8267.8 8557.5 6835.2 7271.1 7348.0 7371.6 7372.6 5190.5 5319.9 5411.3 5462.6 5487.9 5365.9 5407.6 5438.9 5505.3 5629.7 13:07:34 INFO - PROCESS | 25707 | 13:07:34 INFO - PROCESS | 25707 | [#4] prototype.html Cycles:180 Average:4670.15 Median:5166.56 stddev:1387.12 (26.8%) stddev-sans-first:1352.06 13:07:34 INFO - PROCESS | 25707 | Values: 321.5 323.4 330.9 337.8 348.3 5346.9 5403.9 5412.2 5424.0 5475.8 5320.0 5323.0 5333.2 5340.5 5372.8 4224.3 4231.6 4246.3 4256.7 4261.2 3782.4 4078.7 4101.7 4184.7 4253.1 4195.9 4200.7 4213.3 4227.9 4242.6 4246.3 4261.2 4270.3 4272.7 4274.5 3463.9 3766.3 3795.7 3796.9 3800.9 5222.9 5226.0 5253.3 5281.2 5286.8 4714.0 4721.9 4729.6 4731.6 4744.1 5470.6 5583.3 5592.0 5603.2 5637.2 3979.4 3979.5 3987.8 3999.2 4014.5 5539.8 5682.3 5794.8 5794.9 5797.6 3991.8 4068.6 4069.7 4072.4 4076.7 4142.7 4146.6 4147.0 4156.3 4166.6 4705.6 4782.9 4787.8 4796.5 4819.1 5620.6 5685.4 5698.8 5710.6 5720.9 1432.6 1439.3 1442.7 1442.8 1443.4 864.2 909.2 926.2 946.5 951.2 4767.0 4778.7 4824.8 4828.0 4842.8 5068.3 5074.3 5100.9 5120.6 5121.3 4510.7 4756.7 4772.3 4802.8 4827.6 2653.2 2681.9 2688.6 2695.9 2708.6 5101.4 5134.6 5157.2 5168.6 5184.9 5130.3 5161.4 5164.5 5585.5 6030.9 5922.7 5945.4 5947.3 5955.6 5970.6 5870.2 5881.9 5890.4 5908.6 5936.2 5563.8 5808.0 5827.3 5828.4 5849.9 5764.3 5926.6 5941.8 5949.4 5976.8 4187.6 4238.2 4266.5 4267.5 4270.7 5727.2 5864.3 5886.0 5922.9 5924.0 5690.5 5706.5 5731.4 5771.0 5776.5 5697.9 5709.0 5754.9 5775.7 5806.9 5552.3 5730.3 5744.5 5755.4 5792.7 5779.0 5786.2 5786.3 5789.9 5823.1 5634.7 5672.1 5678.3 5706.1 5715.3 13:07:34 INFO - PROCESS | 25707 | 13:07:34 INFO - PROCESS | 25707 | [#5] yui.html Cycles:180 Average:19661.93 Median:4408.07 stddev:28158.99 (638.8%) stddev-sans-first:28201.82 13:07:34 INFO - PROCESS | 25707 | Values: 655.6 686.3 698.9 702.3 726.6 15406.9 16714.3 16784.3 16886.3 16887.2 14374.3 14481.4 14641.2 15171.9 15255.7 786.5 797.6 804.2 805.3 808.1 796.2 799.9 800.4 801.9 803.7 693.2 712.6 839.5 840.3 844.3 802.5 822.6 823.5 828.5 830.4 596.1 597.6 597.9 597.9 604.0 14712.7 14762.2 14786.3 14790.6 14863.8 13729.9 13823.4 13895.7 14008.0 14082.4 12307.4 12416.9 12706.2 12817.2 12836.4 4183.3 4270.5 4327.8 4354.8 4368.7 76208.0 76432.2 77573.6 77791.6 78199.6 10628.6 11012.0 11095.3 11141.2 11545.6 21420.0 21437.8 21468.7 21829.1 21873.6 7749.7 7944.2 7982.5 8131.4 8151.1 4365.2 4387.6 4428.6 4537.3 4544.5 3454.6 3592.2 3597.2 3609.0 3609.9 587.8 595.5 602.5 606.9 618.8 582.9 604.9 617.3 632.3 647.0 8299.7 8569.9 8830.6 9067.6 9119.5 587.7 588.8 609.8 621.6 641.9 3981.7 4289.3 4378.4 4433.4 4462.3 61133.7 71746.0 117448.4 125806.7 125820.0 84616.6 101602.0 102470.5 104480.5 104966.0 50984.5 51864.0 74948.3 79411.6 85484.6 8182.5 8692.3 8961.9 9094.2 9114.0 48994.8 49711.5 50425.5 50995.5 52266.5 63068.7 71054.0 71853.3 72295.0 74153.6 10897.6 11231.9 11364.3 12613.8 12815.9 13692.9 13799.4 13968.4 14549.0 14600.2 12460.7 12514.4 12749.4 12999.9 14013.3 13630.6 13720.6 13770.2 14000.5 14221.3 13025.4 13034.9 13719.9 14075.5 14088.3 10603.1 10651.6 10715.9 10748.2 10960.2 8324.6 10124.0 10434.5 10712.6 11196.3 13:07:34 INFO - PROCESS | 25707 | -------- Summary: end -------- 13:07:34 INFO - PROCESS | 25707 | 13:07:35 INFO - TEST-INFO | 25707: exit 0 13:07:35 INFO - TEST-OK | dromaeo_css | took 1114552ms 13:07:35 INFO - TEST-START | kraken 13:07:35 INFO - operating with platform_type : linux_ 13:07:35 INFO - Initialising browser for kraken test... 13:07:35 INFO - TEST-INFO | started process 26073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNTcEAU/profile http://localhost:48876/getInfo.html) 13:07:40 INFO - PROCESS | 26073 | __metrics Screen width/height:1600/1200 13:07:40 INFO - PROCESS | 26073 | colorDepth:24 13:07:40 INFO - PROCESS | 26073 | Browser inner width/height: 1024/697 13:07:40 INFO - PROCESS | 26073 | __metrics 13:07:41 ERROR - PROCESS | 26073 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 13:07:42 INFO - TEST-INFO | 26073: exit 0 13:07:42 INFO - Browser initialized. 13:07:42 INFO - Running cycle 1/1 for kraken test... 13:07:42 INFO - TEST-INFO | started process 26196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNTcEAU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:07:54 INFO - PROCESS | 26196 | RSS: Main: 185225216 13:07:54 INFO - PROCESS | 26196 | 13:07:57 INFO - PROCESS | 26196 | Cycle 1(1): loaded http://localhost:48876/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48876/tests/kraken/driver.html?testName=audio-beat-detection) 13:07:57 INFO - PROCESS | 26196 | RSS: Main: 199401472 13:07:57 INFO - PROCESS | 26196 | 13:08:00 INFO - PROCESS | 26196 | Cycle 1(1): loaded http://localhost:48876/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48876/tests/kraken/driver.html?testName=audio-dft) 13:08:01 INFO - PROCESS | 26196 | RSS: Main: 197029888 13:08:01 INFO - PROCESS | 26196 | 13:08:04 INFO - PROCESS | 26196 | Cycle 1(1): loaded http://localhost:48876/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48876/tests/kraken/driver.html?testName=audio-fft) 13:08:04 INFO - PROCESS | 26196 | RSS: Main: 192880640 13:08:04 INFO - PROCESS | 26196 | 13:08:06 INFO - PROCESS | 26196 | Cycle 1(1): loaded http://localhost:48876/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48876/tests/kraken/driver.html?testName=audio-oscillator) 13:08:07 INFO - PROCESS | 26196 | RSS: Main: 193368064 13:08:07 INFO - PROCESS | 26196 | 13:08:09 INFO - PROCESS | 26196 | Cycle 1(1): loaded http://localhost:48876/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48876/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:08:10 INFO - PROCESS | 26196 | RSS: Main: 193945600 13:08:10 INFO - PROCESS | 26196 | 13:08:13 INFO - PROCESS | 26196 | Cycle 1(1): loaded http://localhost:48876/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48876/tests/kraken/driver.html?testName=imaging-darkroom) 13:08:13 INFO - PROCESS | 26196 | RSS: Main: 193974272 13:08:13 INFO - PROCESS | 26196 | 13:08:17 INFO - PROCESS | 26196 | Cycle 1(1): loaded http://localhost:48876/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48876/tests/kraken/driver.html?testName=imaging-desaturate) 13:08:17 INFO - PROCESS | 26196 | RSS: Main: 192086016 13:08:17 INFO - PROCESS | 26196 | 13:08:20 INFO - PROCESS | 26196 | Cycle 1(1): loaded http://localhost:48876/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48876/tests/kraken/driver.html?testName=json-parse-financial) 13:08:21 INFO - PROCESS | 26196 | RSS: Main: 192987136 13:08:21 INFO - PROCESS | 26196 | 13:08:23 INFO - PROCESS | 26196 | Cycle 1(1): loaded http://localhost:48876/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48876/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:08:23 INFO - PROCESS | 26196 | RSS: Main: 193454080 13:08:23 INFO - PROCESS | 26196 | 13:08:25 INFO - PROCESS | 26196 | Cycle 1(1): loaded http://localhost:48876/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48876/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:08:26 INFO - PROCESS | 26196 | RSS: Main: 193347584 13:08:26 INFO - PROCESS | 26196 | 13:08:28 INFO - PROCESS | 26196 | Cycle 1(1): loaded http://localhost:48876/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48876/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:08:28 INFO - PROCESS | 26196 | RSS: Main: 193724416 13:08:28 INFO - PROCESS | 26196 | 13:08:31 INFO - PROCESS | 26196 | Cycle 1(1): loaded http://localhost:48876/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48876/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:08:32 INFO - PROCESS | 26196 | RSS: Main: 193847296 13:08:32 INFO - PROCESS | 26196 | 13:08:35 INFO - PROCESS | 26196 | Cycle 1(1): loaded http://localhost:48876/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48876/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:08:35 INFO - PROCESS | 26196 | RSS: Main: 194154496 13:08:35 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | Cycle 1(1): loaded http://localhost:48876/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48876/tests/kraken/driver.html?testName=ai-astar) 13:08:37 INFO - PROCESS | 26196 | RSS: Main: 195502080 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | __start_tp_report 13:08:37 INFO - PROCESS | 26196 | _x_x_mozilla_page_load 13:08:37 INFO - PROCESS | 26196 | _x_x_mozilla_page_load_details 13:08:37 INFO - PROCESS | 26196 | |i|pagename|runs| 13:08:37 INFO - PROCESS | 26196 | |0;ai-astar;106;112;112;112;112;112;112;111;113;112 13:08:37 INFO - PROCESS | 26196 | |1;audio-beat-detection;155;124;124;153;126;127;130;123;158;130 13:08:37 INFO - PROCESS | 26196 | |2;audio-dft;164;164;167;169;166;162;162;161;162;169 13:08:37 INFO - PROCESS | 26196 | |3;audio-fft;75;75;77;112;76;76;76;76;100;76 13:08:37 INFO - PROCESS | 26196 | |4;audio-oscillator;83;81;106;82;83;84;101;82;81;116 13:08:37 INFO - PROCESS | 26196 | |5;imaging-gaussian-blur;117;118;117;118;117;118;117;117;118;117 13:08:37 INFO - PROCESS | 26196 | |6;imaging-darkroom;148;148;147;147;147;147;147;149;149;147 13:08:37 INFO - PROCESS | 26196 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;95;96 13:08:37 INFO - PROCESS | 26196 | |8;json-parse-financial;55;54;54;58;56;56;66;55;56;56 13:08:37 INFO - PROCESS | 26196 | |9;json-stringify-tinderbox;63;63;62;62;64;62;63;62;62;64 13:08:37 INFO - PROCESS | 26196 | |10;stanford-crypto-aes;81;81;84;81;80;88;79;79;79;81 13:08:37 INFO - PROCESS | 26196 | |11;stanford-crypto-ccm;145;132;130;139;137;144;155;136;166;130 13:08:37 INFO - PROCESS | 26196 | |12;stanford-crypto-pbkdf2;164;171;167;169;168;166;168;168;179;164 13:08:37 INFO - PROCESS | 26196 | |13;stanford-crypto-sha256-iterative;67;67;67;65;65;66;66;66;69;66 13:08:37 INFO - PROCESS | 26196 | __end_tp_report 13:08:37 INFO - PROCESS | 26196 | __start_cc_report 13:08:37 INFO - PROCESS | 26196 | _x_x_mozilla_cycle_collect,771 13:08:37 INFO - PROCESS | 26196 | __end_cc_report 13:08:37 INFO - PROCESS | 26196 | __startTimestamp1475784517680__endTimestamp 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | ------- Summary: start ------- 13:08:37 INFO - PROCESS | 26196 | Number of tests: 14 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:1.96 (1.7%) stddev-sans-first:0.50 13:08:37 INFO - PROCESS | 26196 | Values: 106.0 112.0 112.0 112.0 112.0 112.0 112.0 111.0 113.0 112.0 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:130.00 stddev:14.28 (11.0%) stddev-sans-first:13.18 13:08:37 INFO - PROCESS | 26196 | Values: 155.0 124.0 124.0 153.0 126.0 127.0 130.0 123.0 158.0 130.0 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | [#2] audio-dft Cycles:10 Average:164.60 Median:165.00 stddev:2.99 (1.8%) stddev-sans-first:3.16 13:08:37 INFO - PROCESS | 26196 | Values: 164.0 164.0 167.0 169.0 166.0 162.0 162.0 161.0 162.0 169.0 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:13.03 (17.1%) stddev-sans-first:13.57 13:08:37 INFO - PROCESS | 26196 | Values: 75.0 75.0 77.0 112.0 76.0 76.0 76.0 76.0 100.0 76.0 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:82.00 stddev:12.81 (15.6%) stddev-sans-first:13.34 13:08:37 INFO - PROCESS | 26196 | Values: 83.0 81.0 106.0 82.0 83.0 84.0 101.0 82.0 81.0 116.0 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 13:08:37 INFO - PROCESS | 26196 | Values: 117.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 118.0 117.0 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 13:08:37 INFO - PROCESS | 26196 | Values: 148.0 148.0 147.0 147.0 147.0 147.0 147.0 149.0 149.0 147.0 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:08:37 INFO - PROCESS | 26196 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.00 stddev:3.50 (6.3%) stddev-sans-first:3.67 13:08:37 INFO - PROCESS | 26196 | Values: 55.0 54.0 54.0 58.0 56.0 56.0 66.0 55.0 56.0 56.0 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 13:08:37 INFO - PROCESS | 26196 | Values: 63.0 63.0 62.0 62.0 64.0 62.0 63.0 62.0 62.0 64.0 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.00 stddev:2.79 (3.4%) stddev-sans-first:2.96 13:08:37 INFO - PROCESS | 26196 | Values: 81.0 81.0 84.0 81.0 80.0 88.0 79.0 79.0 79.0 81.0 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:141.50 stddev:11.61 (8.2%) stddev-sans-first:12.24 13:08:37 INFO - PROCESS | 26196 | Values: 145.0 132.0 130.0 139.0 137.0 144.0 155.0 136.0 166.0 130.0 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:168.00 stddev:4.30 (2.6%) stddev-sans-first:4.26 13:08:37 INFO - PROCESS | 26196 | Values: 164.0 171.0 167.0 169.0 168.0 166.0 168.0 168.0 179.0 164.0 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.17 (1.8%) stddev-sans-first:1.22 13:08:37 INFO - PROCESS | 26196 | Values: 67.0 67.0 67.0 65.0 65.0 66.0 66.0 66.0 69.0 66.0 13:08:37 INFO - PROCESS | 26196 | -------- Summary: end -------- 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | 13:08:37 INFO - PROCESS | 26196 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 13:08:37 INFO - PROCESS | 26196 | 13:08:38 INFO - TEST-INFO | 26196: exit 0 13:08:38 INFO - TEST-OK | kraken | took 62843ms 13:08:38 INFO - SUITE-END | took 1177s 13:08:38 INFO - Completed test suite (00:19:37) 13:08:38 INFO - javascript benchmark 13:08:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7135.603734943122, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3011.894583689571, 3045.573619693242, 3073.3853229354136, 3076.3847230553893, 3088.6139232595924, 5155.793768249266, 5239.5546378557865, 5301.6818990860575, 5302.996461029128, 5360.0, 5206.531412172903, 5278.287431196787, 5290.788368465266, 5292.1003429417, 5324.787008519665, 4771.785269662856, 4834.637402194832, 4848.296996935443, 4875.24433712775, 4894.290327902452, 4883.19427294496, 4894.094592500381, 4923.507649235084, 4933.309336692848, 4964.0816448956875, 4676.415448068991, 4708.152532544141, 4861.854144375674, 4867.0, 4930.063287975291, 4754.286856971447, 4788.832390866338, 4809.302651115604, 4821.373221481185, 4891.633127515415, 4772.42730872294, 4777.689450185761, 4786.282057691339, 4789.042191561667, 4849.684770489942, 5044.672096313728, 5254.605904557136, 5314.256004159421, 5336.226247194174, 5351.09031464652, 5389.8113566025395, 5478.315210598676, 5513.173024046385, 5567.192757050205, 5666.716664166816, 5617.157426386034, 5622.606417550773, 5631.7465714042555, 5633.126865335879, 5654.7842213924205, 5239.187925871496, 5239.633225674204, 5250.369955605313, 5289.920651190235, 5298.993191293642, 5611.130274807329, 5650.604457687922, 5718.51392631631, 5793.391693872167, 5804.100364443518, 5583.832485025456, 5592.720363981784, 5600.187972743929, 5609.27079479665, 5665.178549110356, 5480.205370221295, 5595.21666966625, 5687.459691329317, 5689.48794608479, 5698.7435565399655, 5475.507204351547, 5580.972095139579, 5640.182173584807, 5648.74580643872, 5745.85635359111, 5647.265855438849, 5688.146777983336, 5692.316921969307, 5698.031334673115, 5704.34400043992, 4364.956350436519, 4371.737695738266, 4379.0, 4388.5830846069575, 4442.666799990014, 3817.1602247505502, 3818.0645741792882, 3830.9808450958126, 3836.712246581462, 3881.514810648669, 5289.867753306121, 5319.388270348882, 5324.068288049576, 5331.306930099062, 5401.945980540144, 5589.552835773128, 5593.468620481048, 5612.607117501736, 5618.719064046863, 5637.408072152365, 5182.222666600041, 5221.295125158055, 5245.344331958505, 5273.050850846885, 5333.599980001515, 4804.231322988305, 4812.35033270511, 4821.710697358169, 4857.247126695368, 4872.8781780455065, 5682.431756824284, 5691.90833784172, 5699.430056994351, 5719.885602287848, 5767.769289228384, 5537.889242215214, 5555.777768889199, 5601.663900166003, 5603.299587551556, 5614.466625670555, 5696.829095127153, 5741.1388291756575, 5754.079347304411, 5821.301443826598, 5822.0, 5549.667019978653, 5575.080111781511, 5585.609007369445, 5588.608797384144, 5591.217229587943, 5452.645578037414, 5502.559795216293, 5694.202811606461, 5707.543396528351, 5724.341700704305, 5400.243965844864, 5450.890982180414, 5455.618106732491, 5459.672419654833, 5459.890802184013, 5439.238506609157, 5449.863753406196, 5460.180972854104, 5460.290162278879, 5460.453954604508, 5318.042752304622, 5385.703786291791, 5414.404415514369, 5421.701806400686, 5423.3491980962535, 5479.0411677957, 5497.972510137423, 5506.421825708243, 5507.586930980113, 5533.253010843646, 5358.437364076872, 5397.514223719884, 5403.0544654686055, 5407.188921661625, 5468.91796623059], "value": 5187.758547817198, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.5054003017375, 577.4196932083257, 590.8995470769971, 595.8510372406898, 596.8090211132437, 41094.38358424626, 42727.30908436484, 42771.57228427715, 46952.530474695246, 46959.76520117403, 45428.545714542845, 45535.54464455354, 45713.7714311428, 45791.0, 45968.3104753429, 8742.650293988232, 8857.247133993618, 8880.24517915978, 8898.555072246394, 8913.68802091927, 8832.779180520474, 8899.199072083511, 8903.688370907019, 8903.688370907019, 8920.197182253596, 8835.425697329685, 8902.688405905794, 8929.374943753939, 8973.685920992766, 8987.0, 8890.199882010618, 8901.554922253861, 8917.910820891773, 8929.642814287421, 8950.149735775123, 8727.912720872773, 8817.515036672981, 8849.292056635519, 8855.07021762712, 8889.111088891059, 41443.585564144276, 41989.58010419918, 42064.36903446451, 42136.57863421388, 42231.0, 3424.9486257706153, 3483.5645544306963, 3844.8269827857534, 3891.9610803891883, 3924.607539246081, 30490.0, 30568.694313056807, 30604.846975765202, 30883.84558077195, 31597.526037109234, 4198.809677067943, 4314.956850431518, 4380.430544029287, 4438.933415998763, 4503.684742068057, 341100.0, 344933.0, 346501.2674936634, 347014.0, 347122.0, 53214.0, 53575.19637205445, 53602.19596706053, 53630.0, 53636.46363536393, 57682.0, 57698.4230157693, 57769.4223057764, 57791.711041445364, 57840.0, 15452.690946181014, 15621.765673514907, 15646.139462329453, 15647.061176329456, 15659.217039147998, 12441.75116497665, 12664.556740514037, 12670.049746269067, 12701.809472857729, 12702.142018045866, 13430.0, 15346.0, 15347.23263836826, 15446.5366039019, 15620.0, 5650.74571644277, 5730.971345143247, 5772.595918285764, 5821.505172060422, 5916.822495325147, 945.2768631996528, 986.9506524673737, 1031.7162780235344, 1049.6116436918237, 1092.3118435385657, 31246.375072498424, 31343.68656313453, 31372.215694607818, 31464.213394664857, 31759.52360714591, 1072.254782925859, 1089.7548051688466, 1116.5812820192427, 1135.920485566019, 1219.536576101076, 16748.330066797436, 17338.479845604652, 17410.303587856342, 17940.641187176185, 18386.26454941814, 561666.0, 562655.0, 564636.0, 565930.0, 567724.0, 55648.0, 56530.43469565334, 56552.71723641438, 56572.717136414874, 56858.0, 1289.6775806048488, 1310.3579246169309, 1364.7202323523654, 1367.7469668111232, 1383.280694039094, 28619.0, 30589.847050764605, 31113.844430777703, 31419.528707068956, 32168.517472238404, 47583.28625070696, 48991.26513102378, 49007.0, 49058.264126038855, 49059.5094049055, 440088.0, 441368.0, 442076.0, 442830.0, 443095.0, 25067.0, 25638.0, 25764.484710305314, 25845.870770646026, 27177.45645087127, 44760.55239447694, 44765.552344476135, 45699.0, 46281.53718462772, 46871.0, 38277.80861095677, 38841.6115838838, 38912.33052033774, 40459.19081618292, 40784.3882341771, 38762.28663993494, 38842.41736374013, 39052.41421378625, 39966.600333996284, 40642.59357406388, 38741.6125838738, 39457.40813887736, 39629.40555891721, 39759.204815902944, 39872.40191397073, 32945.835270823496, 34679.8620482829, 35022.47466287957, 35964.28071438609, 36113.63886361103, 27043.053493127645, 27075.45849082968, 27204.863975679997, 27272.727272727814, 27322.590161147997], "value": 19569.222457625678, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.75640224859444, 391.23318296139564, 398.930187217237, 399.73817149766904, 422.47570764681035, 14402.927985360086, 18219.635607287863, 18934.011928747488, 19904.70142947855, 19921.701174482376, 18333.908330458362, 18580.349687760932, 19345.22619095238, 19626.705599415985, 19682.311119110833, 5619.775208991636, 5624.578156638258, 5788.5369170466265, 5842.591018628697, 5849.649021058729, 5718.399568045358, 5764.423557644244, 5791.7972870949525, 5793.913091303612, 5805.477507024367, 5592.105263157896, 5694.117411801178, 5785.537157027427, 5787.623804452718, 5798.101294299369, 5579.553635709133, 5720.599558030939, 5776.162456443834, 5788.594798364116, 5810.854728631797, 5613.971930140323, 5746.597738158289, 5757.107648314518, 5759.308882934033, 5779.653220806765, 13050.2822344771, 14481.710365792731, 22145.44636384087, 22910.0, 23048.308550743506, 2186.30038387716, 2210.1380461619983, 2246.2475070851283, 2248.910043598254, 2447.681801365811, 9351.579178936965, 9626.51867406634, 9678.95160524193, 9775.755606109833, 10156.695299141038, 1893.2616279650947, 1901.6291823094502, 1913.1486488512617, 1924.441911845563, 1953.9511512212166, 75339.62330188314, 81628.9999999994, 83238.0, 83623.0, 85757.57121214416, 10067.194624430029, 10158.644447444452, 10405.635802746867, 10424.895751042544, 10538.894611053945, 13480.191188528719, 14075.788863167061, 14119.788203176755, 14123.929380353238, 14341.354639041268, 7506.587137707369, 7650.885236721454, 7869.409794265453, 7912.169222231698, 8120.279706298338, 7389.519681220703, 7420.295071968154, 7438.4049276057785, 7616.35261002821, 7727.150013498511, 4680.9297860532115, 4704.482506924304, 4760.33355330254, 4776.2119250324, 4809.95190048102, 1946.698261769428, 1996.6106609211065, 1997.7902320256455, 1999.4701404127918, 2062.824659903895, 866.9479831210148, 883.1698203688512, 914.7895983923735, 1012.0284526854156, 1053.9683809485728, 17881.37415190462, 19321.130549125322, 19327.613447730968, 19382.903085484482, 19833.611647184847, 983.2036050798876, 988.5897352598735, 994.9801003979879, 1011.9949400252951, 1037.5019990404649, 10217.642382516726, 10998.395088270221, 11069.446527673585, 11078.501467433985, 11106.222564420576, 406921.0, 407132.0, 434946.0, 436965.0, 440070.0, 88864.5556772212, 91389.0, 91718.54140729387, 92203.53898230466, 92561.0, 988.8763904511936, 988.960441582343, 995.6850322999056, 1027.7430642339416, 1032.0, 16305.59236019109, 16739.581510462336, 17025.0, 18479.168437420616, 18822.341218057303, 30944.381112378076, 35997.46003809893, 41146.1770764589, 45045.54954450414, 45311.555051306146, 52135.0, 52630.73684631552, 53352.733236333566, 61675.383246168756, 63053.684731576046, 8083.232092951161, 8103.716369927024, 8189.181081891763, 8267.255946964802, 8411.45325553837, 11397.544098235978, 13127.0, 13234.139780914209, 13375.732485350043, 13413.731725365244, 10629.468526573795, 11199.104071674083, 11245.269057511236, 11442.885571144181, 11794.05647548177, 10145.64490242838, 10739.677809665722, 10851.077658399125, 10889.509972051435, 11311.151663625096, 11743.941280293544, 11849.407529623311, 11877.881221187678, 11879.940600296943, 12217.266963982189, 8263.256306932404, 8273.172682731678, 8290.502569845828, 8315.376346773895, 8692.391532592657, 9211.539423028687, 10571.418571978615, 10871.891281087088, 11027.0, 11054.336739795637], "value": 8961.814853085236, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1422.900396972212, 1461.6126726417494, 1646.4648989078553, 1797.4338083503687, 1811.0401487211775, 8319.66721331146, 8610.52642104684, 8968.372213945026, 9702.320837541374, 9711.514424278794, 8624.310055195585, 8956.373053886215, 9012.233960113383, 9249.676261330855, 9313.16181543661, 2313.4332088638266, 2339.63735620979, 2347.9060837566476, 2349.1777877742825, 2350.788429041386, 2277.407873952776, 2278.7037685100913, 2331.4870728439714, 2334.953300933989, 2338.53229354129, 2334.8832558372096, 2342.906283748648, 2356.964645530318, 2367.4673198530277, 2374.6556749271344, 2199.417154454071, 2210.7568167501563, 2216.2797090945505, 2218.744844342889, 2220.123051394698, 2270.3302525754943, 2271.0, 2274.715660542432, 2290.5075408787025, 2295.426143464134, 9312.208462280714, 9478.099580539838, 9493.193078588329, 9502.287328450393, 9533.427994320364, 5221.347331583552, 5345.850642111965, 5370.167624018283, 5375.596830237748, 5389.541888939445, 3312.029342541184, 3352.2625022495013, 3482.547268855058, 3520.6655367740022, 3526.523919270917, 1267.2206592945365, 1273.197885332244, 1290.6837824733, 1294.8122522234223, 2114.143771772435, 12994.090413671047, 13390.732185356239, 13508.459661613524, 13529.255890925995, 13608.931955340258, 4259.531451540328, 4493.662975276802, 4587.243104887656, 4591.517890621503, 4594.33382159585, 10430.426326552113, 10439.164866810637, 10471.371717696962, 10489.842652360221, 10500.0, 5296.285001524745, 5332.200169974457, 5341.545968592635, 5355.625106242604, 5357.0, 4486.5962063414445, 4740.644451666139, 4806.303086052572, 4830.033993201374, 4972.080165169383, 3796.4115562087923, 3914.8825535233987, 3946.8421263149726, 3972.6027397260623, 3981.5421226558738, 1170.1633332167542, 1194.778965891313, 1198.6344165029575, 1206.4256145729908, 1207.5109580619862, 952.3238500664468, 987.7283746969497, 1001.689476262361, 1006.0492834271689, 1008.6721815410021, 5853.443922827325, 5974.0, 5983.670898100646, 6175.59858609189, 6274.435300822948, 447.1593404399708, 454.7953420960581, 455.60362484637915, 458.3331253026838, 461.35180071998224, 4076.490438695163, 4280.871573852789, 4295.162443323522, 4455.309427038814, 4489.124620698998, 11719.414029298501, 12031.518739250332, 12051.397430128458, 12129.514819407124, 12134.0, 10940.781184376268, 11615.186936914504, 11734.002609778094, 12142.210756300989, 12142.635720928387, 8610.526421046903, 8631.0, 8749.387542871938, 8799.516026618598, 8971.955140224387, 6288.402601752826, 6423.96788016057, 6547.541672082908, 6604.174478190226, 6629.237637671729, 10462.47687615601, 10873.238873279111, 10909.0, 11097.556097756, 11122.833157502482, 11006.449677516252, 11158.776824463628, 11172.273802202832, 11176.658800943938, 11242.100631949588, 8042.919570804451, 8146.83706325882, 8352.665893364197, 8479.15208479147, 8486.660533578835, 9281.953590232275, 9351.345405821527, 9412.623495060121, 9421.764455888657, 9443.669471568463, 7954.164812694815, 7994.0, 8059.0, 8321.209485098905, 8539.74380768578, 8067.171714659509, 8213.95893020531, 8235.876461852957, 8267.751967440987, 8557.48655080697, 6835.21395039557, 7271.127464704058, 7348.0, 7371.631418429164, 7372.63136843145, 5190.455002224712, 5319.920201197063, 5411.3224900279465, 5462.617616766788, 5487.890242195054, 5365.865853353541, 5407.567394608343, 5438.918416223839, 5505.284313039279, 5629.718514074198], "value": 4738.16861585663, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.54661926683366, 323.4210762734705, 330.92779394760964, 337.81251405469953, 348.34163431115184, 5346.91979620306, 5403.864903377417, 5412.161115027167, 5423.972880135599, 5475.78096876125, 5319.973400133003, 5322.973385133078, 5333.2000199970025, 5340.49265319794, 5372.758225879835, 4224.324108142698, 4231.645873320531, 4246.341817018367, 4256.680429066983, 4261.21167583998, 3782.3948168293077, 4078.7348822326453, 4101.671866250693, 4184.707070505051, 4253.1493701259715, 4195.874073815012, 4200.726952748061, 4213.346931225665, 4227.87316380509, 4242.596953289448, 4246.3205887058075, 4261.169072030955, 4270.252705776507, 4272.722273052242, 4274.465691788527, 3463.930721385583, 3766.2844059628583, 3795.734298599099, 3796.9430458543143, 3800.9094997751404, 5222.92165617516, 5225.99505284463, 5253.317068781034, 5281.151596941078, 5286.762095705664, 4714.0, 4721.905561888743, 4729.628407761779, 4731.621470282369, 4744.098621261984, 5470.64440811346, 5583.274174357308, 5592.0, 5603.215549823028, 5637.154426835967, 3979.4428779970826, 3979.5025621797276, 3987.8205480753436, 3999.24014437256, 4014.45804816349, 5539.806106786243, 5682.346530149044, 5794.82615521535, 5794.88410231793, 5797.565182611321, 3991.8004099794894, 4068.613481719232, 4069.654079403225, 4072.429859819628, 4076.7146299758733, 4142.668586513072, 4146.564610715832, 4147.0, 4156.334986402161, 4166.645835103989, 4705.635365743896, 4782.880427989328, 4787.760611969387, 4796.544328288807, 4819.132556139928, 5620.5503559715125, 5685.431456854281, 5698.751711524391, 5710.600257981984, 5720.914186287126, 1432.5630682641895, 1439.2659743530664, 1442.7159827753308, 1442.809682012323, 1443.3617843747213, 864.2308345572445, 909.1681111782777, 926.1895841139003, 946.4888959961544, 951.2247518272724, 4767.0, 4778.737169455644, 4824.758762061883, 4827.9825109306685, 4842.806287748521, 5068.315777370081, 5074.2895994560795, 5100.948990510122, 5120.61595380348, 5121.334226550524, 4510.691899349152, 4756.6908150970075, 4772.308015337757, 4802.807887684523, 4827.562081149067, 2653.150991682643, 2681.8927242910063, 2688.637034000385, 2695.9056433025144, 2708.5937109433744, 5101.387833460009, 5134.614903882224, 5157.249666621689, 5168.586513078944, 5184.870378240575, 5130.256112863689, 5161.4322424533275, 5164.535191832678, 5585.4865310610385, 6030.909536356959, 5922.733476993546, 5945.40545945402, 5947.31605865331, 5955.612885162451, 5970.552208584373, 5870.236869207147, 5881.911771323348, 5890.352061273171, 5908.615939963888, 5936.22829032223, 5563.805266815642, 5808.0, 5827.3007239131575, 5828.44629760189, 5849.94150058511, 5764.279465066867, 5926.585139040226, 5941.7623295067715, 5949.3753155918, 5976.820695378971, 4187.576224083826, 4238.1523695261685, 4266.5093514246255, 4267.5305716371795, 4270.654743755707, 5727.226824378656, 5864.296284445893, 5885.970570147293, 5922.9338719029265, 5923.970380148244, 5690.459406356389, 5706.543476521952, 5731.426857314235, 5771.018926782541, 5776.537876969916, 5697.857553561194, 5708.974243650871, 5754.8849023018465, 5775.653460792366, 5806.883862322646, 5552.278203833475, 5730.312362516524, 5744.454276843693, 5755.36690964002, 5792.7103644818435, 5778.971105144616, 5786.218860453785, 5786.334571524329, 5789.942100579109, 5823.126531020381, 5634.661920284796, 5672.149177623224, 5678.290213723285, 5706.058500347396, 5715.31416230055], "value": 4226.94523095135, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.6459511863593, 686.2896901706735, 698.87070891885, 702.2731472925523, 726.6439444672109, 15406.92296538517, 16714.331426742916, 16784.328626854927, 16886.324547018103, 16887.24007419666, 14374.281285935715, 14481.420743170287, 14641.19473428961, 15171.9379643425, 15255.6948861023, 786.5162924801249, 797.6490344248541, 804.155636581587, 805.3235282362814, 808.0949336742827, 796.2037962037962, 799.856025915335, 800.403699244061, 801.8636831738589, 803.6664784114614, 693.2409012131708, 712.6329940080863, 839.5214727605268, 840.3487297344545, 844.3498506150261, 802.4904185842004, 822.5681517203457, 823.4606332851962, 828.5360198288978, 830.4394533689735, 596.1236981636987, 597.5667640960312, 597.8505373656586, 597.8684689368332, 604.0064094564461, 14712.705745885129, 14762.188079655614, 14786.260686965608, 14790.630234244123, 14863.777043344358, 13729.862701373058, 13823.447062117502, 13895.652608684763, 14008.0, 14082.436702531886, 12307.44616492251, 12416.937915310365, 12706.237625742486, 12817.23096614206, 12836.422360993778, 4183.267928112598, 4270.466191726035, 4327.7619730914785, 4354.7604881731495, 4368.694191406603, 76208.0, 76432.23567764307, 77573.61213193955, 77791.61104194443, 78199.60900195462, 10628.574857005788, 11012.0, 11095.334279943228, 11141.16441266892, 11545.595904143483, 21420.03609837561, 21437.785622143892, 21468.677969830464, 21829.12683492674, 21873.562528749335, 7749.651265693057, 7944.205579442125, 7982.481138725964, 8131.390145739093, 8151.103378628346, 4365.214261432972, 4387.583179597933, 4428.55714428561, 4537.274036154266, 4544.522825103382, 3454.6199918008997, 3592.2456284180616, 3597.172650290448, 3609.0255630979486, 3609.9278014439565, 587.8354060862965, 595.4849055566904, 602.5179856115091, 606.9028955367208, 618.8081694674665, 582.8542864283929, 604.9213602231682, 617.3332800575367, 632.3265722006141, 647.0494544875384, 8299.709510167115, 8569.914300856912, 8830.55847207637, 9067.637294508146, 9119.498427586546, 587.7413937867325, 588.7703795519751, 609.7621827689796, 621.5680102328838, 641.8523739539838, 3981.7013723970817, 4289.313709806478, 4378.365137055172, 4433.401490798766, 4462.286034234507, 61133.69433152806, 71746.0, 117448.41275793737, 125806.67739903269, 125820.0, 84616.57691711502, 101602.0, 102470.48764756278, 104480.47759761305, 104966.0, 50984.49015509798, 51864.0, 74948.25051749522, 79411.60294198492, 85484.57257713797, 8182.4681395709085, 8692.261157801659, 8961.865572016295, 9094.181523662903, 9114.0, 48994.755026224644, 49711.502884972135, 50425.49574504208, 50995.49004510056, 52266.47733522616, 63068.68465657642, 71054.0, 71853.28146718466, 72295.0, 74153.6292318535, 10897.564097436014, 11231.887681123411, 11364.318140911571, 12613.810792838298, 12815.871841281842, 13692.863071369158, 13799.448022079407, 13968.37142328618, 14549.030963245787, 14600.196989165697, 12460.688482788002, 12514.43685034194, 12749.426275817425, 12999.935000324938, 14013.29933503341, 13630.591082267549, 13720.588382348546, 13770.242636654679, 14000.509982150576, 14221.288935552973, 13025.352901187682, 13034.934825325812, 13719.862801372257, 14075.507357242448, 14088.295585220903, 10603.138402042627, 10651.627193048205, 10715.946420267848, 10748.247622666651, 10960.177986651193, 8324.62539185726, 10124.0, 10434.530446130095, 10712.62505812324, 11196.328220306808], "value": 7243.598714150402, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 112.0, 112.0, 112.0, 112.0, 112.0, 111.0, 113.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 124.0, 153.0, 126.0, 127.0, 130.0, 123.0, 158.0, 130.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 167.0, 169.0, 166.0, 162.0, 162.0, 161.0, 162.0, 169.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 112.0, 76.0, 76.0, 76.0, 76.0, 100.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 106.0, 82.0, 83.0, 84.0, 101.0, 82.0, 81.0, 116.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 149.0, 149.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 58.0, 56.0, 56.0, 66.0, 55.0, 56.0, 56.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 64.0, 62.0, 63.0, 62.0, 62.0, 64.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 84.0, 81.0, 80.0, 88.0, 79.0, 79.0, 79.0, 81.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 132.0, 130.0, 139.0, 137.0, 144.0, 155.0, 136.0, 166.0, 130.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 171.0, 167.0, 169.0, 168.0, 166.0, 168.0, 168.0, 179.0, 164.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 65.0, 65.0, 66.0, 66.0, 66.0, 69.0, 66.0], "value": 66.4, "unit": "score"}]}]} 13:08:38 INFO - Return code: 0 13:08:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:08:38 ERROR - # TBPL SUCCESS # 13:08:38 INFO - Running post-action listener: _resource_record_post_action 13:08:38 INFO - [mozharness: 2016-10-06 20:08:38.975392Z] Finished run-tests step (success) 13:08:38 INFO - Running post-run listener: _resource_record_post_run 13:08:39 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 398495744; Read time: 0; Write time: 267412 13:08:39 INFO - TinderboxPrint: CPU usage
13.4% 13:08:39 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:08:39 INFO - TinderboxPrint: I/O write bytes / time
398,495,744 / 267,412 13:08:39 INFO - TinderboxPrint: CPU idle
8,251.2 (86.6%) 13:08:39 INFO - TinderboxPrint: CPU user
1,217.0 (12.8%) 13:08:39 INFO - TinderboxPrint: Swap in / out
0 / 0 13:08:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106635264; Read time: 0; Write time: 86112 13:08:39 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 287948800; Read time: 0; Write time: 180756 13:08:39 INFO - Running post-run listener: _upload_blobber_files 13:08:39 INFO - Blob upload gear active. 13:08:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:08:39 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 13:08:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:08:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:08:40 INFO - (blobuploader) - INFO - Open directory for files ... 13:08:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:08:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:08:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:40 INFO - (blobuploader) - INFO - Done attempting. 13:08:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:08:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:08:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:41 INFO - (blobuploader) - INFO - Done attempting. 13:08:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:08:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:08:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:44 INFO - (blobuploader) - INFO - Done attempting. 13:08:44 INFO - (blobuploader) - INFO - Iteration through files over. 13:08:45 INFO - Return code: 0 13:08:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:08:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:08:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/40bd24281d3cad7413d5152fa2c3c4ef71654039a77079768059dc0b21982c2322c27fd0ad742009e5264c870a86702a97b8f9c698e7aece0902d4bd271cb521", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/70e8b0f2981f436c738ad854817dd0e08b07bd97a3da6f3e485057eab7cb818faa7a163ec8fdf1e31b482e913b8076aac3cad1d2337906ba15ceaa630a67ddc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7933fd34bef54e6989ca2ffe2a2e9c306f2d8eb51b68f93a154de83b7c9ec4cdd6fb79a251f6ba613bb5dd3f3557cb288f09eda99c93741d896456d7e5b5495b"} 13:08:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:08:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:08:45 INFO - Contents: 13:08:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/40bd24281d3cad7413d5152fa2c3c4ef71654039a77079768059dc0b21982c2322c27fd0ad742009e5264c870a86702a97b8f9c698e7aece0902d4bd271cb521", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/70e8b0f2981f436c738ad854817dd0e08b07bd97a3da6f3e485057eab7cb818faa7a163ec8fdf1e31b482e913b8076aac3cad1d2337906ba15ceaa630a67ddc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7933fd34bef54e6989ca2ffe2a2e9c306f2d8eb51b68f93a154de83b7c9ec4cdd6fb79a251f6ba613bb5dd3f3557cb288f09eda99c93741d896456d7e5b5495b"} 13:08:45 INFO - Running post-run listener: copy_logs_to_upload_dir 13:08:45 INFO - Copying logs to upload dir... 13:08:45 INFO - mkdir: /builds/slave/test/build/upload/logs 13:08:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.367567 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-10-06 13:08:44.888590) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 13:08:44.894151) ========= 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=db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/40bd24281d3cad7413d5152fa2c3c4ef71654039a77079768059dc0b21982c2322c27fd0ad742009e5264c870a86702a97b8f9c698e7aece0902d4bd271cb521", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/70e8b0f2981f436c738ad854817dd0e08b07bd97a3da6f3e485057eab7cb818faa7a163ec8fdf1e31b482e913b8076aac3cad1d2337906ba15ceaa630a67ddc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7933fd34bef54e6989ca2ffe2a2e9c306f2d8eb51b68f93a154de83b7c9ec4cdd6fb79a251f6ba613bb5dd3f3557cb288f09eda99c93741d896456d7e5b5495b"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011448 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475771444/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/40bd24281d3cad7413d5152fa2c3c4ef71654039a77079768059dc0b21982c2322c27fd0ad742009e5264c870a86702a97b8f9c698e7aece0902d4bd271cb521", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/70e8b0f2981f436c738ad854817dd0e08b07bd97a3da6f3e485057eab7cb818faa7a163ec8fdf1e31b482e913b8076aac3cad1d2337906ba15ceaa630a67ddc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7933fd34bef54e6989ca2ffe2a2e9c306f2d8eb51b68f93a154de83b7c9ec4cdd6fb79a251f6ba613bb5dd3f3557cb288f09eda99c93741d896456d7e5b5495b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 13:08:44.920533) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 13:08:44.920895) ========= 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=db7e7c15f3ca076d53731445000001ba-1475783288.929090-841072647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 13:08:45.006015) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 13:08:45.006528) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 13:08:45.006989) ========= ========= Total master_lag: 0.27 =========