builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1476439616.8 results: success (0) buildid: 20161014025445 builduid: ea369e47b8f64ed3ba6ad95b8a4b331c revision: d8aafc5269fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 03:06:56.804265) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 03:06:56.804754) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 03:06:56.805092) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 03:06:56.819727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 03:06:56.820073) ========= 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=232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 03:06:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.0M=0s 2016-10-14 03:06:57 (96.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125997 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 03:06:56.959971) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 03:06:56.960309) ========= 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=232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014636 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 03:06:57.010158) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 03:06:57.010513) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev d8aafc5269fb --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 d8aafc5269fb --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=232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 03:06:57,823 Setting DEBUG logging. 2016-10-14 03:06:57,823 attempt 1/10 2016-10-14 03:06:57,823 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/d8aafc5269fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 03:06:58,140 unpacking tar archive at: autoland-d8aafc5269fb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646836 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 03:06:57.670690) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 03:06:57.670999) ========= script_repo_revision: d8aafc5269fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 03:06:57.671407) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 03:06:57.671761) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 03:06:57.680269) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-14 03:06:57.680547) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:06:58 INFO - MultiFileLogger online at 20161014 03:06:58 in /builds/slave/test 03:06:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 03:06:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:06:58 INFO - {'append_to_log': False, 03:06:58 INFO - 'base_work_dir': '/builds/slave/test', 03:06:58 INFO - 'blob_upload_branch': 'Autoland', 03:06:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:06:58 INFO - 'branch': 'Autoland', 03:06:58 INFO - 'buildbot_json_path': 'buildprops.json', 03:06:58 INFO - 'config_files': ('talos/linux_config.py',), 03:06:58 INFO - 'default_actions': ('clobber', 03:06:58 INFO - 'read-buildbot-config', 03:06:58 INFO - 'download-and-extract', 03:06:58 INFO - 'populate-webroot', 03:06:58 INFO - 'create-virtualenv', 03:06:58 INFO - 'install', 03:06:58 INFO - 'run-tests'), 03:06:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:06:58 INFO - 'download_minidump_stackwalk': True, 03:06:58 INFO - 'download_symbols': 'ondemand', 03:06:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:06:58 INFO - 'tooltool.py': '/tools/tooltool.py', 03:06:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:06:58 INFO - '/tools/misc-python/virtualenv.py')}, 03:06:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:06:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:06:58 INFO - 'installer_path': 'installer.exe', 03:06:58 INFO - 'log_level': 'info', 03:06:58 INFO - 'log_name': 'talos', 03:06:58 INFO - 'log_to_console': True, 03:06:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:06:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:06:58 INFO - 'opt_config_files': (), 03:06:58 INFO - 'pip_index': False, 03:06:58 INFO - 'sps_profile': False, 03:06:58 INFO - 'sps_profile_interval': 0, 03:06:58 INFO - 'suite': 'dromaeojs', 03:06:58 INFO - 'system_bits': '32', 03:06:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:06:58 INFO - 'title': 'talos-linux64-ix-025', 03:06:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:06:58 INFO - 'use_talos_json': True, 03:06:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:06:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:06:58 INFO - 'work_dir': 'build'} 03:06:58 INFO - [mozharness: 2016-10-14 10:06:58.593349Z] Running clobber step. 03:06:58 INFO - Running pre-action listener: _resource_record_pre_action 03:06:58 INFO - Running main action method: clobber 03:06:58 INFO - rmtree: /builds/slave/test/build 03:06:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:06:59 INFO - Running post-action listener: _resource_record_post_action 03:06:59 INFO - [mozharness: 2016-10-14 10:06:59.106717Z] Finished clobber step (success) 03:06:59 INFO - [mozharness: 2016-10-14 10:06:59.106817Z] Running read-buildbot-config step. 03:06:59 INFO - Running pre-action listener: _resource_record_pre_action 03:06:59 INFO - Running main action method: read_buildbot_config 03:06:59 INFO - Using buildbot properties: 03:06:59 INFO - { 03:06:59 INFO - "project": "", 03:06:59 INFO - "product": "firefox", 03:06:59 INFO - "script_repo_revision": "production", 03:06:59 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 03:06:59 INFO - "repository": "", 03:06:59 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 03:06:59 INFO - "buildid": "20161014025445", 03:06:59 INFO - "stage_platform": "linux64-pgo", 03:06:59 INFO - "basedir": "/builds/slave/test", 03:06:59 INFO - "buildnumber": 346, 03:06:59 INFO - "platform": "ubuntu64_hw", 03:06:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:06:59 INFO - "slavebuilddir": "test", 03:06:59 INFO - "branch": "autoland", 03:06:59 INFO - "revision": "d8aafc5269fb", 03:06:59 INFO - "slavename": "talos-linux64-ix-025", 03:06:59 INFO - "builduid": "ea369e47b8f64ed3ba6ad95b8a4b331c", 03:06:59 INFO - "repo_path": "integration/autoland" 03:06:59 INFO - } 03:06:59 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 03:06:59 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 03:06:59 INFO - Running post-action listener: _resource_record_post_action 03:06:59 INFO - [mozharness: 2016-10-14 10:06:59.109156Z] Finished read-buildbot-config step (success) 03:06:59 INFO - [mozharness: 2016-10-14 10:06:59.109243Z] Running download-and-extract step. 03:06:59 INFO - Running pre-action listener: _resource_record_pre_action 03:06:59 INFO - Running main action method: download_and_extract 03:06:59 INFO - mkdir: /builds/slave/test/build/tests 03:06:59 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')]} 03:06:59 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:06:59 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/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 03:06:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/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 03:06:59 INFO - Downloaded 1361 bytes. 03:06:59 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:06:59 INFO - Using the following test package requirements: 03:06:59 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:06:59 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:06:59 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:06:59 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:59 INFO - u'jsshell-linux-x86_64.zip'], 03:06:59 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:06:59 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:06:59 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:06:59 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:06:59 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:06:59 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:06:59 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:06:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:06:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:06:59 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:06:59 INFO - Http code: 200 03:06:59 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 03:06:59 INFO - x-amz-cf-id: C7IqrJq3CvogmXor4xXlB6tBw4jguzZeYwNm8euSTH8pZp4svz0Ktg== 03:06:59 INFO - x-amz-replication-status: COMPLETED 03:06:59 INFO - x-amz-version-id: XVJrCLVmfL674A7dnRBDXUY4pJ0ZOmeY 03:06:59 INFO - Expected file size: 22121436 03:06:59 INFO - Obtained file size: 22121436 03:07:03 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 03:07:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:07:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:07:03 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:07:03 INFO - Http code: 200 03:07:03 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 03:07:03 INFO - x-amz-cf-id: K0zNKlZYthBpT54fvIRN-8qDnEIMersVBdeobc4C9s0bDfr5ppFh_w== 03:07:03 INFO - x-amz-replication-status: COMPLETED 03:07:03 INFO - x-amz-version-id: XVJrCLVmfL674A7dnRBDXUY4pJ0ZOmeY 03:07:03 INFO - Expected file size: 22121436 03:07:03 INFO - Obtained file size: 22121436 03:07:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 03:07:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:07:08 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:07:08 INFO - Http code: 200 03:07:08 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 03:07:08 INFO - x-amz-cf-id: 6HqibxyRP2i6TbJB_8tkrCRD-qfzCN8D4FWaFlSd9NSWMzL6KZzckQ== 03:07:08 INFO - x-amz-replication-status: COMPLETED 03:07:08 INFO - x-amz-version-id: zv36rEZtszh_lA2Bit_vVPstFFOxhXsY 03:07:08 INFO - Expected file size: 14409006 03:07:08 INFO - Obtained file size: 14409006 03:07:08 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')]} 03:07:08 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:07:08 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/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 03:07:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/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 03:07:09 INFO - Downloaded 59668885 bytes. 03:07:09 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:07:09 INFO - mkdir: /builds/slave/test/properties 03:07:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:07:09 INFO - Writing to file /builds/slave/test/properties/build_url 03:07:09 INFO - Contents: 03:07:09 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:07:09 INFO - Running post-action listener: _resource_record_post_action 03:07:09 INFO - Running post-action listener: set_extra_try_arguments 03:07:09 INFO - [mozharness: 2016-10-14 10:07:09.735297Z] Finished download-and-extract step (success) 03:07:09 INFO - [mozharness: 2016-10-14 10:07:09.735523Z] Running populate-webroot step. 03:07:09 INFO - Running pre-action listener: _resource_record_pre_action 03:07:09 INFO - Running main action method: populate_webroot 03:07:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:07:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:07:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:07:09 INFO - '--tppagecycles', 03:07:09 INFO - '7'], 03:07:09 INFO - 'tests': ['tsvgm']}}, 03:07:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:07:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:07:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:07:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:07:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:07:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:07:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:09 INFO - 'talos_options': ['--disable-e10s'], 03:07:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:09 INFO - 'talos_options': ['--disable-e10s'], 03:07:09 INFO - 'tests': ['damp', 'tps']}, 03:07:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:09 INFO - 'tests': ['damp', 'tps']}, 03:07:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:07:09 INFO - 'tests': ['dromaeo_dom']}, 03:07:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:07:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:07:09 INFO - 'tests': ['basic_compositor_video']}, 03:07:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:07:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:07:09 INFO - 'tests': ['a11yr', 03:07:09 INFO - 'ts_paint', 03:07:09 INFO - 'tpaint', 03:07:09 INFO - 'sessionrestore', 03:07:09 INFO - 'sessionrestore_no_auto_restore', 03:07:09 INFO - 'tabpaint']}, 03:07:09 INFO - 'other-e10s': {'tests': ['a11yr', 03:07:09 INFO - 'ts_paint', 03:07:09 INFO - 'tpaint', 03:07:09 INFO - 'sessionrestore', 03:07:09 INFO - 'sessionrestore_no_auto_restore', 03:07:09 INFO - 'tabpaint']}, 03:07:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:07:09 INFO - 'ts_paint', 03:07:09 INFO - 'tpaint', 03:07:09 INFO - 'sessionrestore', 03:07:09 INFO - 'sessionrestore_no_auto_restore', 03:07:09 INFO - 'tabpaint']}, 03:07:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:07:09 INFO - 'ts_paint', 03:07:09 INFO - 'tpaint', 03:07:09 INFO - 'sessionrestore', 03:07:09 INFO - 'sessionrestore_no_auto_restore', 03:07:09 INFO - 'tabpaint']}, 03:07:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:07:09 INFO - 'tests': ['a11yr', 03:07:09 INFO - 'ts_paint', 03:07:09 INFO - 'tpaint', 03:07:09 INFO - 'sessionrestore', 03:07:09 INFO - 'sessionrestore_no_auto_restore', 03:07:09 INFO - 'tabpaint']}, 03:07:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:07:09 INFO - 'tests': ['a11yr', 03:07:09 INFO - 'ts_paint', 03:07:09 INFO - 'tpaint', 03:07:09 INFO - 'sessionrestore', 03:07:09 INFO - 'sessionrestore_no_auto_restore', 03:07:09 INFO - 'tabpaint']}, 03:07:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:07:09 INFO - 'tests': ['tsvgx', 03:07:09 INFO - 'tsvgr_opacity', 03:07:09 INFO - 'tart', 03:07:09 INFO - 'tscrollx', 03:07:09 INFO - 'cart']}, 03:07:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:07:09 INFO - 'tsvgr_opacity', 03:07:09 INFO - 'tart', 03:07:09 INFO - 'tscrollx', 03:07:09 INFO - 'cart']}, 03:07:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:09 INFO - 'talos_options': ['--disable-e10s'], 03:07:09 INFO - 'tests': ['tp5o']}, 03:07:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:09 INFO - 'tests': ['tp5o']}, 03:07:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:09 INFO - 'talos_options': ['--disable-e10s', 03:07:09 INFO - '--xperf_path', 03:07:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:09 INFO - 'tests': ['tp5n']}, 03:07:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:09 INFO - 'talos_options': ['--xperf_path', 03:07:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:09 INFO - 'tests': ['tp5n']}}, 03:07:09 INFO - 'talos.zip': {'path': '', 03:07:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:07:09 INFO - Running post-action listener: _resource_record_post_action 03:07:09 INFO - [mozharness: 2016-10-14 10:07:09.752399Z] Finished populate-webroot step (success) 03:07:09 INFO - [mozharness: 2016-10-14 10:07:09.752486Z] Running create-virtualenv step. 03:07:09 INFO - Running pre-action listener: _resource_record_pre_action 03:07:09 INFO - Running main action method: create_virtualenv 03:07:09 INFO - Creating virtualenv /builds/slave/test/build/venv 03:07:09 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 03:07:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:07:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:07:09 INFO - Using real prefix '/usr' 03:07:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:07:10 INFO - Installing distribute.............................................................................................................................................................................................done. 03:07:12 INFO - Installing pip.................done. 03:07:12 INFO - Return code: 0 03:07:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:07:12 INFO - Reading from file tmpfile_stdout 03:07:12 INFO - Output received: 03:07:12 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) 03:07:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:07:12 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')]} 03:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:12 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')]} 03:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:12 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 0x7fa56bd50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be07b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f790>, '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 0x2c70690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c70b20>, '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': '232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448', '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 03:07:12 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 03:07:12 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 03:07:12 INFO - Using env: {'DISPLAY': ':0', 03:07:12 INFO - 'HOME': '/home/cltbld', 03:07:12 INFO - 'LANG': 'en_US.UTF-8', 03:07:12 INFO - 'LANGUAGE': 'en_US:en', 03:07:12 INFO - 'LOGNAME': 'cltbld', 03:07:12 INFO - 'MAIL': '/var/mail/cltbld', 03:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:12 INFO - 'MOZ_NO_REMOTE': '1', 03:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:12 INFO - 'NO_EM_RESTART': '1', 03:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:12 INFO - 'PWD': '/builds/slave/test', 03:07:12 INFO - 'SHELL': '/bin/bash', 03:07:12 INFO - 'SHLVL': '1', 03:07:12 INFO - 'TERM': 'linux', 03:07:12 INFO - 'TMOUT': '86400', 03:07:12 INFO - 'USER': 'cltbld', 03:07:12 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448', 03:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:12 INFO - '_': '/tools/buildbot/bin/python'} 03:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:12 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 03:07:12 INFO - Cleaning up... 03:07:12 INFO - Return code: 0 03:07:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:07:12 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')]} 03:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:12 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')]} 03:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:12 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 0x7fa56bd50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be07b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f790>, '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 0x2c70690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c70b20>, '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': '232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448', '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 03:07:12 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 03:07:12 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 03:07:12 INFO - Using env: {'DISPLAY': ':0', 03:07:12 INFO - 'HOME': '/home/cltbld', 03:07:12 INFO - 'LANG': 'en_US.UTF-8', 03:07:12 INFO - 'LANGUAGE': 'en_US:en', 03:07:12 INFO - 'LOGNAME': 'cltbld', 03:07:12 INFO - 'MAIL': '/var/mail/cltbld', 03:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:12 INFO - 'MOZ_NO_REMOTE': '1', 03:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:12 INFO - 'NO_EM_RESTART': '1', 03:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:12 INFO - 'PWD': '/builds/slave/test', 03:07:12 INFO - 'SHELL': '/bin/bash', 03:07:12 INFO - 'SHLVL': '1', 03:07:12 INFO - 'TERM': 'linux', 03:07:12 INFO - 'TMOUT': '86400', 03:07:12 INFO - 'USER': 'cltbld', 03:07:12 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448', 03:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:12 INFO - '_': '/tools/buildbot/bin/python'} 03:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:12 INFO - Downloading/unpacking psutil>=3.1.1 03:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:07:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:07:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:07:15 INFO - Installing collected packages: psutil 03:07:15 INFO - Running setup.py install for psutil 03:07:15 INFO - building 'psutil._psutil_linux' extension 03:07:15 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 03:07:15 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 03:07:15 INFO - building 'psutil._psutil_posix' extension 03:07:15 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 03:07:15 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 03:07:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:07:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:07:15 INFO - Successfully installed psutil 03:07:15 INFO - Cleaning up... 03:07:15 INFO - Return code: 0 03:07:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:15 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 0x7fa56bd50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be07b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f790>, '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 0x2c70690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c70b20>, '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': '232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448', '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 03:07:15 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 03:07:15 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 03:07:15 INFO - Using env: {'DISPLAY': ':0', 03:07:15 INFO - 'HOME': '/home/cltbld', 03:07:15 INFO - 'LANG': 'en_US.UTF-8', 03:07:15 INFO - 'LANGUAGE': 'en_US:en', 03:07:15 INFO - 'LOGNAME': 'cltbld', 03:07:15 INFO - 'MAIL': '/var/mail/cltbld', 03:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:15 INFO - 'MOZ_NO_REMOTE': '1', 03:07:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:15 INFO - 'NO_EM_RESTART': '1', 03:07:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:15 INFO - 'PWD': '/builds/slave/test', 03:07:15 INFO - 'SHELL': '/bin/bash', 03:07:15 INFO - 'SHLVL': '1', 03:07:15 INFO - 'TERM': 'linux', 03:07:15 INFO - 'TMOUT': '86400', 03:07:15 INFO - 'USER': 'cltbld', 03:07:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448', 03:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:15 INFO - '_': '/tools/buildbot/bin/python'} 03:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:07:15 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 03:07:15 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 03:07:15 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 03:07:15 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 03:07:15 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 03:07:15 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 03:07:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:07:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:07:17 INFO - Installing collected packages: mozsystemmonitor 03:07:17 INFO - Running setup.py install for mozsystemmonitor 03:07:17 INFO - Successfully installed mozsystemmonitor 03:07:17 INFO - Cleaning up... 03:07:17 INFO - Return code: 0 03:07:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:07:17 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')]} 03:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:17 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')]} 03:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:17 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 0x7fa56bd50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be07b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f790>, '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 0x2c70690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c70b20>, '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': '232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448', '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 03:07:17 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 03:07:17 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 03:07:17 INFO - Using env: {'DISPLAY': ':0', 03:07:17 INFO - 'HOME': '/home/cltbld', 03:07:17 INFO - 'LANG': 'en_US.UTF-8', 03:07:17 INFO - 'LANGUAGE': 'en_US:en', 03:07:17 INFO - 'LOGNAME': 'cltbld', 03:07:17 INFO - 'MAIL': '/var/mail/cltbld', 03:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:17 INFO - 'MOZ_NO_REMOTE': '1', 03:07:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:17 INFO - 'NO_EM_RESTART': '1', 03:07:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:17 INFO - 'PWD': '/builds/slave/test', 03:07:17 INFO - 'SHELL': '/bin/bash', 03:07:17 INFO - 'SHLVL': '1', 03:07:17 INFO - 'TERM': 'linux', 03:07:17 INFO - 'TMOUT': '86400', 03:07:17 INFO - 'USER': 'cltbld', 03:07:17 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448', 03:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:17 INFO - '_': '/tools/buildbot/bin/python'} 03:07:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:18 INFO - Downloading/unpacking jsonschema==2.5.1 03:07:18 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 03:07:18 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 03:07:18 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 03:07:18 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 03:07:18 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 03:07:18 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 03:07:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:07:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:20 INFO - Downloading functools32-3.2.3-2.tar.gz 03:07:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:07:20 INFO - warning: no files found matching '*.txt' 03:07:20 INFO - no previously-included directories found matching 'build' 03:07:20 INFO - no previously-included directories found matching 'dist' 03:07:20 INFO - no previously-included directories found matching '.git*' 03:07:20 INFO - Installing collected packages: jsonschema, functools32 03:07:20 INFO - Running setup.py install for functools32 03:07:20 INFO - warning: no files found matching '*.txt' 03:07:20 INFO - no previously-included directories found matching 'build' 03:07:20 INFO - no previously-included directories found matching 'dist' 03:07:20 INFO - no previously-included directories found matching '.git*' 03:07:20 INFO - Successfully installed jsonschema functools32 03:07:20 INFO - Cleaning up... 03:07:20 INFO - Return code: 0 03:07:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:07: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')]} 03:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07: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')]} 03:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:20 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 0x7fa56bd50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be07b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f790>, '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 0x2c70690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c70b20>, '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': '232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448', '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 03:07:20 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 03:07:20 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 03:07:20 INFO - Using env: {'DISPLAY': ':0', 03:07:20 INFO - 'HOME': '/home/cltbld', 03:07:20 INFO - 'LANG': 'en_US.UTF-8', 03:07:20 INFO - 'LANGUAGE': 'en_US:en', 03:07:20 INFO - 'LOGNAME': 'cltbld', 03:07:20 INFO - 'MAIL': '/var/mail/cltbld', 03:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:20 INFO - 'MOZ_NO_REMOTE': '1', 03:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:20 INFO - 'NO_EM_RESTART': '1', 03:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:20 INFO - 'PWD': '/builds/slave/test', 03:07:20 INFO - 'SHELL': '/bin/bash', 03:07:20 INFO - 'SHLVL': '1', 03:07:20 INFO - 'TERM': 'linux', 03:07:20 INFO - 'TMOUT': '86400', 03:07:20 INFO - 'USER': 'cltbld', 03:07:20 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448', 03:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:20 INFO - '_': '/tools/buildbot/bin/python'} 03:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:07:20 INFO - Cleaning up... 03:07:20 INFO - Return code: 0 03:07:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:07: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')]} 03:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07: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')]} 03:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:20 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 0x7fa56bd50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be07b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f790>, '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 0x2c70690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c70b20>, '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': '232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448', '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 03:07:20 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 03:07:20 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 03:07:20 INFO - Using env: {'DISPLAY': ':0', 03:07:20 INFO - 'HOME': '/home/cltbld', 03:07:20 INFO - 'LANG': 'en_US.UTF-8', 03:07:20 INFO - 'LANGUAGE': 'en_US:en', 03:07:20 INFO - 'LOGNAME': 'cltbld', 03:07:20 INFO - 'MAIL': '/var/mail/cltbld', 03:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:20 INFO - 'MOZ_NO_REMOTE': '1', 03:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:20 INFO - 'NO_EM_RESTART': '1', 03:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:20 INFO - 'PWD': '/builds/slave/test', 03:07:20 INFO - 'SHELL': '/bin/bash', 03:07:20 INFO - 'SHLVL': '1', 03:07:20 INFO - 'TERM': 'linux', 03:07:20 INFO - 'TMOUT': '86400', 03:07:20 INFO - 'USER': 'cltbld', 03:07:20 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448', 03:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:20 INFO - '_': '/tools/buildbot/bin/python'} 03:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:20 INFO - Downloading/unpacking blobuploader==1.2.4 03:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:23 INFO - Downloading blobuploader-1.2.4.tar.gz 03:07:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:07:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:07:23 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 03:07:23 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 03:07:23 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 03:07:23 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 03:07:23 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 03:07:23 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 03:07:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:07:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:07:23 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 03:07:23 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 03:07:23 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 03:07:23 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 03:07:23 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 03:07:23 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 03:07:23 INFO - Downloading docopt-0.6.1.tar.gz 03:07:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:07:23 INFO - Installing collected packages: blobuploader, requests, docopt 03:07:23 INFO - Running setup.py install for blobuploader 03:07:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:07:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:07:24 INFO - Running setup.py install for requests 03:07:24 INFO - Running setup.py install for docopt 03:07:24 INFO - Successfully installed blobuploader requests docopt 03:07:24 INFO - Cleaning up... 03:07:24 INFO - Return code: 0 03:07:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07: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')]} 03:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07: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')]} 03:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:24 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 0x7fa56bd50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be07b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f790>, '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 0x2c70690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c70b20>, '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': '232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448', '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 03:07:24 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 03:07:24 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 03:07:24 INFO - Using env: {'DISPLAY': ':0', 03:07:24 INFO - 'HOME': '/home/cltbld', 03:07:24 INFO - 'LANG': 'en_US.UTF-8', 03:07:24 INFO - 'LANGUAGE': 'en_US:en', 03:07:24 INFO - 'LOGNAME': 'cltbld', 03:07:24 INFO - 'MAIL': '/var/mail/cltbld', 03:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:24 INFO - 'MOZ_NO_REMOTE': '1', 03:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:24 INFO - 'NO_EM_RESTART': '1', 03:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:24 INFO - 'PWD': '/builds/slave/test', 03:07:24 INFO - 'SHELL': '/bin/bash', 03:07:24 INFO - 'SHLVL': '1', 03:07:24 INFO - 'TERM': 'linux', 03:07:24 INFO - 'TMOUT': '86400', 03:07:24 INFO - 'USER': 'cltbld', 03:07:24 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448', 03:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:24 INFO - '_': '/tools/buildbot/bin/python'} 03:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:24 INFO - Running setup.py (path:/tmp/pip-017mC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:24 INFO - Running setup.py (path:/tmp/pip-eNhWPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:24 INFO - Running setup.py (path:/tmp/pip-FGZjCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:24 INFO - Running setup.py (path:/tmp/pip-sLd5YZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:25 INFO - Running setup.py (path:/tmp/pip-KBZ4Gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:25 INFO - Running setup.py (path:/tmp/pip-YA5JoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:25 INFO - Running setup.py (path:/tmp/pip-u5f7Be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:25 INFO - Running setup.py (path:/tmp/pip-6udkGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:25 INFO - Running setup.py (path:/tmp/pip-8oHd_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:25 INFO - Running setup.py (path:/tmp/pip-YkJbYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:25 INFO - Running setup.py (path:/tmp/pip-4LY8PD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:25 INFO - Running setup.py (path:/tmp/pip-QzrqCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:25 INFO - Running setup.py (path:/tmp/pip-EfTrgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:25 INFO - Running setup.py (path:/tmp/pip-lS6s8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:25 INFO - Running setup.py (path:/tmp/pip-aq7Kg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:25 INFO - Running setup.py (path:/tmp/pip-Yp3hoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:25 INFO - Running setup.py (path:/tmp/pip-P3PH2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:07:25 INFO - Running setup.py install for manifestparser 03:07:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:07:26 INFO - Running setup.py install for mozcrash 03:07:26 INFO - Running setup.py install for mozdebug 03:07:26 INFO - Running setup.py install for mozdevice 03:07:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:07:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:07:26 INFO - Running setup.py install for mozfile 03:07:26 INFO - Running setup.py install for mozhttpd 03:07:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:07:26 INFO - Running setup.py install for mozinfo 03:07:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:07:26 INFO - Running setup.py install for mozInstall 03:07:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:07:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:07:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:07:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:07:26 INFO - Running setup.py install for mozleak 03:07:26 INFO - Running setup.py install for mozlog 03:07:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:07:27 INFO - Running setup.py install for moznetwork 03:07:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:07:27 INFO - Running setup.py install for mozprocess 03:07:27 INFO - Running setup.py install for mozprofile 03:07:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:07:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:07:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:07:27 INFO - Running setup.py install for mozrunner 03:07:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:07:27 INFO - Running setup.py install for mozscreenshot 03:07:27 INFO - Running setup.py install for moztest 03:07:27 INFO - Running setup.py install for mozversion 03:07:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:07:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:07:27 INFO - Cleaning up... 03:07:27 INFO - Return code: 0 03:07:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07: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')]} 03:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07: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')]} 03:07:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:27 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 0x7fa56bd50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be07b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f790>, '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 0x2c70690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c70b20>, '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': '232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448', '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 03:07:27 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 03:07:27 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 03:07:27 INFO - Using env: {'DISPLAY': ':0', 03:07:27 INFO - 'HOME': '/home/cltbld', 03:07:27 INFO - 'LANG': 'en_US.UTF-8', 03:07:27 INFO - 'LANGUAGE': 'en_US:en', 03:07:27 INFO - 'LOGNAME': 'cltbld', 03:07:27 INFO - 'MAIL': '/var/mail/cltbld', 03:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:27 INFO - 'MOZ_NO_REMOTE': '1', 03:07:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:27 INFO - 'NO_EM_RESTART': '1', 03:07:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:27 INFO - 'PWD': '/builds/slave/test', 03:07:27 INFO - 'SHELL': '/bin/bash', 03:07:27 INFO - 'SHLVL': '1', 03:07:27 INFO - 'TERM': 'linux', 03:07:27 INFO - 'TMOUT': '86400', 03:07:27 INFO - 'USER': 'cltbld', 03:07:27 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448', 03:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:27 INFO - '_': '/tools/buildbot/bin/python'} 03:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:28 INFO - Running setup.py (path:/tmp/pip-2vYImo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:28 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)) 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:28 INFO - Running setup.py (path:/tmp/pip-l2V3TW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:28 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)) 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:28 INFO - Running setup.py (path:/tmp/pip-b9qKLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:28 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)) 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:28 INFO - Running setup.py (path:/tmp/pip-fbCRWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:28 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)) 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:28 INFO - Running setup.py (path:/tmp/pip-PhJHbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:28 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)) 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:28 INFO - Running setup.py (path:/tmp/pip-MV1n8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:28 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)) 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:28 INFO - Running setup.py (path:/tmp/pip-PAXoDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:28 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)) 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:28 INFO - Running setup.py (path:/tmp/pip-iVhAoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:28 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)) 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:28 INFO - Running setup.py (path:/tmp/pip-JmcFcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:28 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)) 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:28 INFO - Running setup.py (path:/tmp/pip-BH0dB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:28 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)) 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:28 INFO - Running setup.py (path:/tmp/pip-LKuB0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:28 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)) 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:28 INFO - Running setup.py (path:/tmp/pip-AjgOjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:28 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)) 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:28 INFO - Running setup.py (path:/tmp/pip-yVVNV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:28 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)) 03:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:28 INFO - Running setup.py (path:/tmp/pip-QOehUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:29 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)) 03:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:29 INFO - Running setup.py (path:/tmp/pip-SYLZyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:29 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)) 03:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:29 INFO - Running setup.py (path:/tmp/pip-UEPNMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:29 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)) 03:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:29 INFO - Running setup.py (path:/tmp/pip-fzzGZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:29 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)) 03:07:29 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)) 03:07:29 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)) 03:07:29 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)) 03:07:29 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)) 03:07:29 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)) 03:07:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:31 INFO - Downloading blessings-1.6.tar.gz 03:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:07:31 INFO - Installing collected packages: blessings 03:07:31 INFO - Running setup.py install for blessings 03:07:31 INFO - Successfully installed blessings 03:07:31 INFO - Cleaning up... 03:07:31 INFO - Return code: 0 03:07:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:07:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:07:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:07:31 INFO - Reading from file tmpfile_stdout 03:07:31 INFO - Current package versions: 03:07:31 INFO - argparse == 1.2.1 03:07:31 INFO - blessings == 1.6 03:07:31 INFO - blobuploader == 1.2.4 03:07:31 INFO - docopt == 0.6.1 03:07:31 INFO - functools32 == 3.2.3-2 03:07:31 INFO - jsonschema == 2.5.1 03:07:31 INFO - manifestparser == 1.1 03:07:31 INFO - mozInstall == 1.12 03:07:31 INFO - mozcrash == 0.17 03:07:31 INFO - mozdebug == 0.1 03:07:31 INFO - mozdevice == 0.48 03:07:31 INFO - mozfile == 1.2 03:07:31 INFO - mozhttpd == 0.7 03:07:31 INFO - mozinfo == 0.9 03:07:31 INFO - mozleak == 0.1 03:07:31 INFO - mozlog == 3.4 03:07:31 INFO - moznetwork == 0.27 03:07:31 INFO - mozprocess == 0.23 03:07:31 INFO - mozprofile == 0.28 03:07:31 INFO - mozrunner == 6.12 03:07:31 INFO - mozscreenshot == 0.1 03:07:31 INFO - mozsystemmonitor == 0.3 03:07:31 INFO - moztest == 0.7 03:07:31 INFO - mozversion == 1.4 03:07:31 INFO - psutil == 3.1.1 03:07:31 INFO - requests == 1.2.3 03:07:31 INFO - wsgiref == 0.1.2 03:07:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:31 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 0x7fa56bd50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be07b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f790>, '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 0x2c70690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c70b20>, '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': '232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448', '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 03:07:31 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 03:07:31 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 03:07:31 INFO - Using env: {'DISPLAY': ':0', 03:07:31 INFO - 'HOME': '/home/cltbld', 03:07:31 INFO - 'LANG': 'en_US.UTF-8', 03:07:31 INFO - 'LANGUAGE': 'en_US:en', 03:07:31 INFO - 'LOGNAME': 'cltbld', 03:07:31 INFO - 'MAIL': '/var/mail/cltbld', 03:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:31 INFO - 'MOZ_NO_REMOTE': '1', 03:07:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:31 INFO - 'NO_EM_RESTART': '1', 03:07:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:31 INFO - 'PWD': '/builds/slave/test', 03:07:31 INFO - 'SHELL': '/bin/bash', 03:07:31 INFO - 'SHLVL': '1', 03:07:31 INFO - 'TERM': 'linux', 03:07:31 INFO - 'TMOUT': '86400', 03:07:31 INFO - 'USER': 'cltbld', 03:07:31 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448', 03:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:31 INFO - '_': '/tools/buildbot/bin/python'} 03:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:31 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)) 03:07:31 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)) 03:07:31 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)) 03:07:31 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)) 03:07:31 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)) 03:07:31 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)) 03:07:31 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)) 03:07:31 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)) 03:07:31 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)) 03:07:31 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)) 03:07:31 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)) 03:07:31 INFO - Cleaning up... 03:07:31 INFO - Return code: 0 03:07:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa56bd50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be07b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f790>, '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 0x2c70690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c70b20>, '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': '232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448', '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 03:07:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:07:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:07:31 INFO - Using env: {'DISPLAY': ':0', 03:07:31 INFO - 'HOME': '/home/cltbld', 03:07:31 INFO - 'LANG': 'en_US.UTF-8', 03:07:31 INFO - 'LANGUAGE': 'en_US:en', 03:07:31 INFO - 'LOGNAME': 'cltbld', 03:07:31 INFO - 'MAIL': '/var/mail/cltbld', 03:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:31 INFO - 'MOZ_NO_REMOTE': '1', 03:07:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:31 INFO - 'NO_EM_RESTART': '1', 03:07:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:31 INFO - 'PWD': '/builds/slave/test', 03:07:31 INFO - 'SHELL': '/bin/bash', 03:07:31 INFO - 'SHLVL': '1', 03:07:31 INFO - 'TERM': 'linux', 03:07:31 INFO - 'TMOUT': '86400', 03:07:31 INFO - 'USER': 'cltbld', 03:07:31 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448', 03:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:31 INFO - '_': '/tools/buildbot/bin/python'} 03:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:07:32 INFO - Cleaning up... 03:07:32 INFO - Return code: 0 03:07:32 INFO - Running post-action listener: _resource_record_post_action 03:07:32 INFO - Running post-action listener: _start_resource_monitoring 03:07:32 INFO - Starting resource monitoring. 03:07:32 INFO - [mozharness: 2016-10-14 10:07:32.147245Z] Finished create-virtualenv step (success) 03:07:32 INFO - [mozharness: 2016-10-14 10:07:32.147750Z] Running install step. 03:07:32 INFO - Running pre-action listener: _resource_record_pre_action 03:07:32 INFO - Running main action method: install 03:07:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:07:32 INFO - Reading from file tmpfile_stdout 03:07:32 INFO - Detecting whether we're running mozinstall >=1.0... 03:07:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:07:32 INFO - Reading from file tmpfile_stdout 03:07:32 INFO - Output received: 03:07:32 INFO - Usage: mozinstall [options] installer 03:07:32 INFO - Options: 03:07:32 INFO - -h, --help show this help message and exit 03:07:32 INFO - -d DEST, --destination=DEST 03:07:32 INFO - Directory to install application into. [default: 03:07:32 INFO - "/builds/slave/test"] 03:07:32 INFO - --app=APP Application being installed. [default: firefox] 03:07:32 INFO - mkdir: /builds/slave/test/build/application 03:07:32 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'] 03:07:32 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 03:07:49 INFO - Reading from file tmpfile_stdout 03:07:49 INFO - Output received: 03:07:49 INFO - /builds/slave/test/build/application/firefox/firefox 03:07:49 INFO - Running post-action listener: _resource_record_post_action 03:07:49 INFO - [mozharness: 2016-10-14 10:07:49.467116Z] Finished install step (success) 03:07:49 INFO - [mozharness: 2016-10-14 10:07:49.467386Z] Running run-tests step. 03:07:49 INFO - Running pre-action listener: _resource_record_pre_action 03:07:49 INFO - Running main action method: run_tests 03:07:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:07:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:07:49 INFO - Python 2.7.3 03:07:49 INFO - Return code: 0 03:07:49 INFO - grabbing minidump binary from tooltool 03:07:49 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')]} 03:07:49 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 0x2c6f790>, '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 0x2c70690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c70b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:07:49 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 03:07:49 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 03:07:49 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 03:07:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:07:49 INFO - Return code: 0 03:07:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:07:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:07:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:07:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:07:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:07:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:07:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:07:49 INFO - Using env: {'DISPLAY': ':0', 03:07:49 INFO - 'HOME': '/home/cltbld', 03:07:49 INFO - 'LANG': 'en_US.UTF-8', 03:07:49 INFO - 'LANGUAGE': 'en_US:en', 03:07:49 INFO - 'LOGNAME': 'cltbld', 03:07:49 INFO - 'MAIL': '/var/mail/cltbld', 03:07:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:07:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:49 INFO - 'MOZ_NO_REMOTE': '1', 03:07:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:49 INFO - 'NO_EM_RESTART': '1', 03:07:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:49 INFO - 'PWD': '/builds/slave/test', 03:07:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:07:49 INFO - 'SHELL': '/bin/bash', 03:07:49 INFO - 'SHLVL': '1', 03:07:49 INFO - 'TERM': 'linux', 03:07:49 INFO - 'TMOUT': '86400', 03:07:49 INFO - 'USER': 'cltbld', 03:07:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448', 03:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:49 INFO - '_': '/tools/buildbot/bin/python'} 03:07:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:07:49 INFO - mozversion application_buildid: 20161013235034 03:07:49 INFO - mozversion application_changeset: d8aafc5269fbf79582ad2f008d71942e35ba29f8 03:07:49 INFO - mozversion application_display_name: Nightly 03:07:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:07:49 INFO - mozversion application_name: Firefox 03:07:49 INFO - mozversion application_remotingname: firefox 03:07:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:07:49 INFO - mozversion application_vendor: Mozilla 03:07:49 INFO - mozversion application_version: 52.0a1 03:07:49 INFO - mozversion platform_buildid: 20161013235034 03:07:49 INFO - mozversion platform_changeset: d8aafc5269fbf79582ad2f008d71942e35ba29f8 03:07:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:07:49 INFO - mozversion platform_version: 52.0a1 03:07:49 INFO - using testdate: 1476439669 03:07:49 INFO - actual date: 1476439669 03:07:49 INFO - starting webserver on 'localhost:45842' 03:07:49 INFO - SUITE-START | Running 2 tests 03:07:49 INFO - TEST-START | dromaeo_css 03:07:49 INFO - operating with platform_type : linux_ 03:07:49 INFO - Initialising browser for dromaeo_css test... 03:07:49 INFO - TEST-INFO | started process 7269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl9Xonx/profile http://localhost:45842/getInfo.html) 03:07:53 INFO - PROCESS | 7269 | __metrics Screen width/height:1600/1200 03:07:53 INFO - PROCESS | 7269 | colorDepth:24 03:07:53 INFO - PROCESS | 7269 | Browser inner width/height: 1024/697 03:07:53 INFO - PROCESS | 7269 | __metrics 03:07:54 INFO - PROCESS | 7269 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:07:54 INFO - PROCESS | 7269 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:07:55 INFO - PROCESS | 7269 | console.error: PushService: 03:07:55 INFO - PROCESS | 7269 | stateChangeProcessEnqueue: Error transitioning state 03:07:55 INFO - PROCESS | 7269 | UnknownError 03:07:55 INFO - TEST-INFO | 7269: exit 0 03:07:55 INFO - Browser initialized. 03:07:55 INFO - Running cycle 1/1 for dromaeo_css test... 03:07:55 INFO - TEST-INFO | started process 7351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl9Xonx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:07 INFO - PROCESS | 7351 | RSS: Main: 177176576 03:08:07 INFO - PROCESS | 7351 | 03:08:59 INFO - PROCESS | 7351 | 1476439739389 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] 03:11:10 INFO - PROCESS | 7351 | Cycle 1(1): loaded http://localhost:45842/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45842/tests/dromaeo/cssquery-ext.html) 03:11:11 INFO - PROCESS | 7351 | RSS: Main: 319938560 03:11:11 INFO - PROCESS | 7351 | 03:14:14 INFO - PROCESS | 7351 | Cycle 1(1): loaded http://localhost:45842/tests/dromaeo/cssquery-ext.html (next: http://localhost:45842/tests/dromaeo/cssquery-jquery.html) 03:14:14 INFO - PROCESS | 7351 | RSS: Main: 276762624 03:14:14 INFO - PROCESS | 7351 | 03:17:17 INFO - PROCESS | 7351 | Cycle 1(1): loaded http://localhost:45842/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45842/tests/dromaeo/cssquery-mootools.html) 03:17:17 INFO - PROCESS | 7351 | RSS: Main: 217284608 03:17:17 INFO - PROCESS | 7351 | 03:20:19 INFO - PROCESS | 7351 | Cycle 1(1): loaded http://localhost:45842/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45842/tests/dromaeo/cssquery-prototype.html) 03:20:20 INFO - PROCESS | 7351 | RSS: Main: 255750144 03:20:20 INFO - PROCESS | 7351 | 03:23:23 INFO - PROCESS | 7351 | Cycle 1(1): loaded http://localhost:45842/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45842/tests/dromaeo/cssquery-yui.html) 03:23:23 INFO - PROCESS | 7351 | RSS: Main: 218439680 03:23:23 INFO - PROCESS | 7351 | 03:26:26 INFO - PROCESS | 7351 | Cycle 1(1): loaded http://localhost:45842/tests/dromaeo/cssquery-yui.html (next: http://localhost:45842/tests/dromaeo/cssquery-dojo.html) 03:26:26 INFO - PROCESS | 7351 | RSS: Main: 305328128 03:26:26 INFO - PROCESS | 7351 | 03:26:26 INFO - PROCESS | 7351 | __start_tp_report 03:26:26 INFO - PROCESS | 7351 | _x_x_mozilla_page_load 03:26:26 INFO - PROCESS | 7351 | _x_x_mozilla_page_load_details 03:26:26 INFO - PROCESS | 7351 | |i|pagename|runs| 03:26:26 INFO - PROCESS | 7351 | |0;dojo.html;2991.341904780948;3018.8641511131996;3026.4249792539417;3043.376107897881;3050.8474576271183;5125.974370128153;5173.560247378968;5209.635325527214;5327.600429967753;5330.973345133274;5241.056609810233;5250.422453530108;5260.0268950244235;5270.683758974455;5274.367075950881;4741.265103908891;4790.449098353682;4810.326554282386;4894.167991441445;4915.139850526161;4806;4809.446913604946;4813;4873.049755297719;4875.536824001714;4144.896377590554;4808.903821923559;4843.806247750086;4848;4909.656324057318;4825.1555977703765;4836.202026665596;4842.757862106881;4899.58353539946;4912.263160525949;4665.346851440801;4703.600193983515;4709.034647897173;4723.126221649006;4753.786079626425;5167.0957582422925;5167.457416971239;5194.92207616886;5245.239440281138;5288.550473209782;5581.469760372758;5607.327120745536;5607.467290607386;5627.80302689408;5691.231683722686;5425.213344065128;5486.835394938158;5508.862278443031;5665.178549110397;5682.346530149044;5167.793288268503;5175.81884634036;5202.08963431398;5203.505666961632;5264.236685680593;5655.6606603603095;5664.603477756517;5667.603267771216;5668.489835914787;5671.943280567141;5346.358436987586;5379.462053794589;5394.757235924393;5541.806036788693;5589.608727389043;5518.53092487135;5555.111182210827;5556.527695145877;5614.1859430382365;5618.634788738719;5546.445355464502;5550.389457159709;5551.306086739158;5552.167174923794;5618.91571626426;5405.297311349578;5424.267723857308;5560.138178582326;5565.471280228372;5569.582281328917;4303.634191093792;4305.74165550068;4306.074194048295;4306.375575541591;4308.74147551148;3868;3872.0707030313088;3884.6115388461494;3891.6497515223764;3906.0430194602504;5313.415524292324;5319.202119682079;5321.175217841241;5322.361316642027;5323.547498462596;5582.33012038558;5596.496315331639;5602;5604.747786349624;5608.242887210256;5362.115250983622;5382.892342153135;5384.111621582473;5384.434634363335;5387.838364849061;4710.26990816424;4820;4822.638302127354;4823.734694591831;4826.469088400273;5656.0950247960955;5746.942530574641;5778.422157784272;5786.421357864264;5789.913151302734;5549.611527193058;5560.777568897199;5563.415841336601;5565.888682226414;5628.577856660685;5679.432056794288;5726.341470730919;5728.054870946247;5817.272840894888;5847.356790752929;5526.917096243479;5543.584231182596;5553.222548843246;5590.357108932362;5612.326520817528;5613.719314034363;5622;5624.35319938196;5630.042892708331;5630.380658127685;5286.286351342519;5355.625106242525;5425.565954723692;5515.117581186991;5519.8128742885565;5424.783008679767;5493.807716729895;5497.47773961473;5544.695041772741;5556.91664625039;5458.235846981346;5461.808836690697;5464.672119672832;5465.59008074388;5468.343798744176;5348.679079255257;5409.6213265071065;5495.670259784426;5513.972430137824;5598.412166722598;5435.755391007335;5489.670619762827;5533.2253484513;5545.500904918576;5547.916781248366 03:26:26 INFO - PROCESS | 7351 | |1;ext.html;538.4738661599396;574.2133277409947;603.4508597176567;605.6456972670993;609.3266940031268;33265.16837079074;34071.318573628516;34071.488927666105;34288;34313.313733725314;35385.64614353856;44096.55903440965;45468.77265613667;45607.77196114023;49010.26484602734;8778.122187781219;8925.241354484844;8936.240419564345;8939.28485721144;8943.865842012376;8813.074627164151;8896.822063558724;8899.28805695546;8903.198712115909;8907.554622268894;8155.551444670541;8355.791105222357;10591.364518128898;10847.294925829796;10871.83692244617;10803.297785643908;10868.402237876913;10871;10875.782484350308;10879.83680244797;10549.10332621728;10603.257771955967;10608.257421980465;10616.946915265451;10618.840717389245;41770.373444398356;41981;42050.369244461355;42069.89986451947;42098.36852447216;3457.7233821294235;3464.133966508373;3501.492283618861;3593.9101522461888;3677.687396571295;30946.226344341347;32170;32206.35587288241;32252.516212256836;33021.3395732084;4056.0831303137215;4301.1827752727195;4339.349097635349;4461.643068554507;4506.121306345264;334560;334726;361532;376266;377000.99999999726;62648;63971.680141599;64030.51404975985;64041.67979160167;64092;66410.66794665996;67042.66478667673;67273.66363168153;67400;67624;16092.275847586887;16257.268422920997;16276.186190690418;16468.83531164697;16482;13128.343582821011;13170.143940643828;13284.867151328557;13292.601221963356;13294.202347858965;17224.311027559008;17601.295948162187;19914.302999394953;20031;20215.696764548542;7248.565086094851;7435.4533770674325;7603.885941710879;7693.461457698019;7717.961410193026;969.2439896880445;987.7728122531714;998.381003777648;1045.0646671229208;1120.2830188679252;31845.248511331636;32228.35543289168;32270;32475.18021215524;32888.835555822545;1049.223574554824;1070.3417398300146;1070.6734445994045;1107.6732363952492;1223.3944197622234;16042.518724438285;16528.83471165273;16600.461206575816;16736.497905062868;16852.662946740995;564525;564825;569300;569368;570339.1483042558;51100.488995109576;51974.48025519696;56457.43542564522;57900;59285.70357148186;1326.7611829870716;1365.5015919189623;1371.5062577471901;1377.9724405512034;1382.3710211853584;31045.534316985715;33663;33688.62047933753;33703.15742106369;34088.82955585206;51855.2221716667;52835.471645283054;52891.47108528866;52903;52952.47047529475;502507;506074;514166;515164;812231;28256.85871570629;42404;42469.787651061546;42864.142717146104;43358;44352;46822;46985.53014469812;47244.527554725384;47735;38706.6129338703;39762.60237397589;40364;40474.59525404708;41381.37927931023;38664.6133538661;39811.220977221536;39968;40404.79797600993;41544.37683434811;41083.383749243185;41552.58447415487;41933.79033104815;42432.15135697207;42445;33313.167170820925;35770.64229357673;36212.27575448424;36521.452178216816;36800;28136.29659258535;28529.42941141207;28610;28617.856910715313;28741.137765867057 03:26:26 INFO - PROCESS | 7351 | |2;jquery.html;386.22947220295515;393.8385262042565;403.45130622353594;405.33525018968885;425.4086819321144;13410.530631427902;15443.15062671554;18987.430377088676;19406.70889936652;19767.30814421492;18188.909055454704;18385.242213667956;18605.81394186058;18908.71636925447;18930.810691893075;5584.664920104787;5662.348829884554;5898.7640494380175;5910.704464776765;5910.763569457216;5696.658200507962;5868.501177399926;5875.735591898375;5877.471027607515;5880.147378630096;3834.5206849143856;4014.4179094031347;5623.26897503324;5874.148248503964;5907.0548712206055;5833.649981001154;5876.2067120938555;5966.433188847074;5968.97015514924;5976.5517586180995;5687.810193075696;5724.112762521774;5731.971340143273;5732.197492351074;5733.283339582552;13737.793933091012;15828.366865325374;21536.78463215379;21914.890425547772;22068.117275308967;2140.892955352226;2172.891355432222;2217.733871935362;2248.5278091600785;2284.1776960294283;9803.754906127333;9951.502424878727;9968.651097211563;11895.464704088337;14322;1848.92604295828;1926.8362189213933;1933.168737442899;1947.8928658923753;1975.940721778349;78938.6053069731;84794.57602711947;85246.57376713138;87911;89557.99999999935;10521.52653130611;10597.205209609156;10799.352038877692;11033.227674062899;11189.929862975376;15661.843381566267;15687.450939217073;15704.685906281811;15714.528564143095;15745.68508629844;7790.493617914817;8045.758627241192;8194.836103277901;8271.793205169919;8275.793105172299;7546.849063018709;7586.582737949356;7637.732679356196;7761.8447631047065;7803.843923121506;4543.5910768031035;4634;4650.67445278834;4748.810047598057;4799.112164249625;1977.2486455146952;1987.930422435208;1999.8600097993292;2014.617222727677;2031.2890488329263;863.7538301584018;918.9678361257323;956.7942892278194;992.1764935103846;1003.9849402258972;17765.911170444324;18640.254389824528;18996.905015474833;19076.61846763057;19333;966.5988614724811;971.2812518736084;989.9356541824758;994.5077186792583;994.9557135480778;10030;10481.213908956859;10487.161027117812;10517.9474102629;10576.682699519026;388932;388987;390890;530031;554146;84485;90668.54665726628;92026;94177.529112354;96441;998.4159266828841;1032.0969151992008;1045.529511719714;1053.2311412668794;1065.0893486069454;16460.42388516396;16670.74993875117;16849.494515164566;17065.488035358958;17759;29939.401211976074;41514.58485415107;42598.36102458404;42842;43735;55810.720946395006;58452.123218152614;58530.4146958542;59927.400725992185;62075.37924620696;7679.424043196671;8093.757187284391;8159.224873636995;8458.40791144614;8615.6984505542;12152.939235303767;12627.431765570755;12663.366831658195;12747.808782868078;12804.743905121659;10686.786264274826;10921.399323037309;11019.283746556768;11185.272957257752;11261.21171517986;11076.107933263535;11091;11155.219134660496;11212.327260364404;11296.717582060186;10590.8411373831;10762.838557421488;11348.829767553658;11431;11600.18798684084;7213;7543.762502681347;7726.343260822893;8200.917990820015;8522.190391912758;10173.389596624227;10735.355878647306;11047.779044419227;11149.609763658233;11449.771004580029 03:26:26 INFO - PROCESS | 7351 | |3;mootools.html;1346.5421756602752;1391.2695834686792;1474.0418727826911;1572.9292181851815;1740.1560243282006;7646.847063058735;8504.829903401927;8797.208251257385;8809.251213646832;9046.140616641425;8803.251723603486;8874.290056795457;8889.466632002084;8889.822203555941;8894.110588941103;2327.208749025331;2333.3000099970027;2335.6613291072786;2356.22244659262;2359.327591636384;2289.461976435536;2334.2297041976108;2336.707911511061;2339.9883000584973;2346.2257455039794;2296.3455415206668;2300.7354154272307;2311.4282288044124;2333.5449587330477;2354.5526349993447;2243.4952135769486;2259.604569200392;2268.5576312619046;2291.427143214205;2292.541491701658;2228.6545585434283;2229.097215627657;2232.441889527618;2237.8321625878125;2267.977320226793;8727.956360218222;8852.955735221283;8923.643054277822;8925.866112008325;8934.4192627479;5185.61107916904;5324.5740340772645;5352.678839269656;5379.462053794589;5409.594280428983;3395.303962687668;3399.8640054397792;3437.415639341318;3486.1458942559234;3500.597431295408;1084.159776173464;1093.7265683579105;1107.6732363952653;1109.4563663804759;1135.1486385211092;12218.877811221952;12238.388080596023;12267.079969002361;12340.259584424874;12350.382480876011;4175.958240417618;4309.159713855768;4440.445843954654;4470.530594287618;4475.888102797456;9465.905340946503;9485.430874147572;9492.762680933032;9502.429854208769;9505.66730164441;5116.130257856174;5117.488251174853;5119.59043276537;5122.590192784568;5123.6157288202785;4267.637250833652;4378.8029538670835;4713.67004309695;4789.473157952622;4823.445303790038;3663.9633603663624;3745.513083299208;3816.904577385588;3846.3076646203394;3864.9227015459533;1156.7281688803125;1163.4706208675032;1169.3802284789076;1177.5172179406402;1189.2567145534042;842.5029232752582;929.9541009778515;947.7298969793576;953.046953046953;987.3927534566191;5642.915356269659;5707.600467967202;5825.79609713658;5840.1239814027385;6114.602550834182;448.1664104765134;457.38938517079407;457.66819056184;458.21873705332996;458.46588724136006;3830.731848770615;3920.3727403615853;3962.841486340572;4012.874681122491;4072.226277007359;10590.205734569938;10924.235303528836;10943.28868623537;10946.397948112772;11003.61487347939;10840.403777792297;10850.186236032328;10868.891311086787;10878.61924832643;10882.129429645609;7691.692332306757;7948.761537153895;8024.478408903519;8038.758837234892;8121.147279535564;5819.388964158702;5907.4683278505145;5916.349201587908;5937.079752638348;6082.847928801639;9518.762030949281;9681.467519286225;9781.51092445389;9946.552405141641;9993.950030249802;9617.134457898823;10044.397336159855;10055.798884022131;10150;10156.695299141038;7493.775186744188;7709.691612335444;7775.494592851673;7805.33654639362;7921.762347129596;8548.487090774574;8592.484450932963;8598.140185981352;8612.741617751477;8613.956930215309;7625.275598818103;7727.9227207729455;7777.650005749641;7837.941877846418;8033.718819841278;7530.774076777706;7608.96195519041;7668.539887606761;7675.270849269311;7687.154413014676;7045.894311585228;7125.251848555827;7132.144142702701;7135.928640713734;7141.321574450419;4920.630952678635;4942.5304596063315;4989.476105009067;5083.38999320084;5334.599905007062;4953.678010929278;5017.724025178651;5182.300389447376;5191.32512773337;5229.137192363218 03:26:26 INFO - PROCESS | 7351 | |4;prototype.html;319.63880814679425;328.1402724860865;334.37471927495585;340.69167403499836;344.5004743122473;5079.542841144296;5178.446466060181;5201.479852014797;5217.556507696846;5254.81608143715;5024.422191447985;5094.949050509494;5105.285260063594;5121.923171152435;5137.178051511759;4098.959010409888;4101.200265948141;4103.322951712964;4112.218678451085;4149.688773341996;3775.7923314217705;3915.725899187058;4123.299039163335;4142.917141657165;4173.520045194796;4025.7181997260204;4103.343465045578;4113.115680128772;4113.25961326961;4114.567970363114;4080;4104.486939132608;4108.5275193352845;4110.4656394668655;4117.547069822317;3690.022144131807;3704.573973992998;3710.239400922804;3714.331420344337;3723.143676954289;4929.852104436837;5043.991201759626;5044.319016932704;5055.342805435306;5072.742629529861;4651.976740116312;4658.487566367697;4658.627309815207;4659.976700116512;4662.976685116552;5386.703731294777;5403.864903377447;5404.270423492818;5409.486098820606;5420.91868621971;3802.790846503441;3920.5496564647096;3956.149427873021;3990.8204130814183;4009.51885773709;5594.2447769551;5650.660960342351;5678.160919540189;5681.829545113653;5695.373508914016;4161.625453709181;4194.832206711759;4216.2832318505925;4221.915561688749;4223.767692776927;3998.3602623580086;4175.352820312856;4176;4211.115665710174;4273.786310684453;4697.624190064855;4701.459332176775;4703.153432382135;4720.976395118071;4722.598579120745;5409.83770486886;5448.91826622601;5464.93433780409;5536.723163841792;5544.556435485151;1403.8245219347582;1444.7905053767145;1448.898577099593;1456.6722487440454;1461.1379286221181;917.3899356927702;947.6114792934864;961.9995204986735;964.4213471916934;971.2424309038961;4618.65360097994;4632.86101416958;4702.061211742661;4710.105080034782;4728.527147285313;4843.104025755176;4846;4872.561469467765;4888.486708895514;4912.017596480719;4493.348464472633;4723.385959825201;4738.336632871401;4738.620910327166;4752;2588.1494731267235;2612.9869350653125;2628.395469042131;2643.7356264373407;2646.4045589742154;5124.48755124492;5137.614678899023;5153.252778347193;5153.922691159635;5174.6377753557645;4850.95149048505;4976.751162441863;4997.600191984705;5012.373453318335;5026.321446604735;5011.819858361624;5066.493350664904;5110.565601923878;5120.308758317654;5136.948630513647;4866.7079975201605;4883.853484395474;4926.211806111149;4943.207087995271;4975.701457912537;4554.402022402265;4824.565789079;4846.539578740014;4859.878503037452;4876.317315575751;4980.32765576657;4993.750312484434;4999.77501012448;5012.77442515095;5063.924041139459;3750.4936833527127;3771.039059689001;3774.4338349247832;3837.6162383761402;3938.5667576565984;5366.838994830161;5486.381517452441;5527.861803454945;5532.253145825262;5535.39110697831;5370.570354371563;5387.595930305321;5398.703071331114;5399.541039011571;5412.648177868426;5200.439868039497;5392.1127605337815;5404.567634589302;5443.918341224964;5451.509364157245;5375.408705042364;5412.2410216678945;5414.891702166014;5442.891142177214;5451.018816613047;5442.537384322377;5491.956528259618;5500.50495455395;5513;5532.695701736282;5214.817481388285;5335.919961200662;5359.946400536101;5385.165299378603;5392.406835248198 03:26:26 INFO - PROCESS | 7351 | |5;yui.html;687.9441737256724;727.3308556128361;739.2533541123464;752.4469514906543;766.3486036868661;15784.36862525499;16737.246823892925;16750.66498670029;16761.245743941523;16772.245248963794;15205.619859503518;15330.080195188297;15388.15365154916;15445.22773861308;15492.69014619707;649.9675016249192;789.5460110436493;794.6424109150877;799.5083023940264;801.0667572278289;663.9402453779159;671.4058058618109;671.4661843834164;671.5500614588213;779.4115442840675;852.86780549015;858.2661824140364;859.4800145911727;859.9656013759442;860.0410542245382;853.799357151069;854.2098558833086;854.8375808596347;855.3029281135854;856.4775486952954;501.5962150468871;509.8444974282842;622.6824319597038;625.4214851262564;625.9092431597438;14403.279836008263;14866.108033518023;14871.33079011447;15445.459408920746;15478.535643930587;14910.329035193443;15275.38898444061;15508.14705191214;15659.21703914811;15985.360585576564;11925.565130510802;11955.08982035928;12304.507819687202;12483.251004939733;12529.498820047187;3817.5991520890184;3853;3908.921821563553;3978.3634618460906;4096.91806163878;81694;81873.59063204646;82014;83091;83967.5801620994;11148.554057837759;11167.888321116847;11270.718232044264;11286.266392684449;11381.374024428736;20302.28941987053;23382.298531044096;23461;23469.88265058664;23488.530229395317;8528.530930798866;8529.95735021321;8566.486010839244;8581.399302048796;8696.260817830555;4537.591616754508;4580.473245576802;4642.6444312090125;4686.203345431285;4907.435644900811;3656.926861462756;3760.8683696071053;3791.962080379216;3793.6722147248242;3801.885943421702;653.4674240494077;663.4891133826926;668.4385116502161;680.0275605883535;686.4439803758871;563.312758434709;602.6444397805228;670.7451168556015;676.1919506190154;681.0941447874316;9123.543822808833;9443.811123777487;9597.520123993772;9709.223262139012;9848.852267215998;615.7752420366534;685.256496701075;685.7874059041714;699.51034276007;712.2094475132599;4591.77041147948;4786.282057691375;4787;4842.6368022398465;4846.442659094178;75145;81590;120772;127402;128575;105757.47121264499;108913.45543272233;109007.45496272467;109643.90356096496;111041.44479277552;87350.56324718335;91282;92863;92912.53543732374;95850.04149958551;8740.91259087401;9147.313951453534;9159;9236.353455258337;9402.52987350616;54813;55273.44726552683;55277.52638017336;55461.72269138628;56411.71794141003;47461.52538474571;48206;48629.75685121552;52320.738396307774;53540.46459535355;10820.18848586375;11465.19743617972;11587.942060289644;12233.510659573873;12359.44985011308;14562.490312839;14938.551843444715;15013.174275414956;15042.398304068152;15291.23543822782;13643.931780341034;13891.047482415492;14181.929090354482;14940.327685253973;14966.700665986837;13708.451661933412;13727.794083088962;14455.638609034859;14606.26968651542;14614.34235459428;13686.247256400595;13758.243296618382;14309;14662;14743;10904.236703431001;11321.264117832314;11462.312261264351;11515;11990.940045299718;11458.484368203284;11820.822687659864;11838.940805295919;12095.879041209475;12105.273683579013 03:26:26 INFO - PROCESS | 7351 | __end_tp_report 03:26:26 INFO - PROCESS | 7351 | __start_cc_report 03:26:26 INFO - PROCESS | 7351 | _x_x_mozilla_cycle_collect,1328 03:26:26 INFO - PROCESS | 7351 | __end_cc_report 03:26:26 INFO - PROCESS | 7351 | __startTimestamp1476440786830__endTimestamp 03:26:26 INFO - PROCESS | 7351 | 03:26:26 INFO - PROCESS | 7351 | ------- Summary: start ------- 03:26:26 INFO - PROCESS | 7351 | Number of tests: 6 03:26:26 INFO - PROCESS | 7351 | 03:26:26 INFO - PROCESS | 7351 | [#0] dojo.html Cycles:165 Average:5204.71 Median:5409.62 stddev:580.26 (10.7%) stddev-sans-first:555.46 03:26:26 INFO - PROCESS | 7351 | Values: 2991.3 3018.9 3026.4 3043.4 3050.8 5126.0 5173.6 5209.6 5327.6 5331.0 5241.1 5250.4 5260.0 5270.7 5274.4 4741.3 4790.4 4810.3 4894.2 4915.1 4806.0 4809.4 4813.0 4873.0 4875.5 4144.9 4808.9 4843.8 4848.0 4909.7 4825.2 4836.2 4842.8 4899.6 4912.3 4665.3 4703.6 4709.0 4723.1 4753.8 5167.1 5167.5 5194.9 5245.2 5288.6 5581.5 5607.3 5607.5 5627.8 5691.2 5425.2 5486.8 5508.9 5665.2 5682.3 5167.8 5175.8 5202.1 5203.5 5264.2 5655.7 5664.6 5667.6 5668.5 5671.9 5346.4 5379.5 5394.8 5541.8 5589.6 5518.5 5555.1 5556.5 5614.2 5618.6 5546.4 5550.4 5551.3 5552.2 5618.9 5405.3 5424.3 5560.1 5565.5 5569.6 4303.6 4305.7 4306.1 4306.4 4308.7 3868.0 3872.1 3884.6 3891.6 3906.0 5313.4 5319.2 5321.2 5322.4 5323.5 5582.3 5596.5 5602.0 5604.7 5608.2 5362.1 5382.9 5384.1 5384.4 5387.8 4710.3 4820.0 4822.6 4823.7 4826.5 5656.1 5746.9 5778.4 5786.4 5789.9 5549.6 5560.8 5563.4 5565.9 5628.6 5679.4 5726.3 5728.1 5817.3 5847.4 5526.9 5543.6 5553.2 5590.4 5612.3 5613.7 5622.0 5624.4 5630.0 5630.4 5286.3 5355.6 5425.6 5515.1 5519.8 5424.8 5493.8 5497.5 5544.7 5556.9 5458.2 5461.8 5464.7 5465.6 5468.3 5348.7 5409.6 5495.7 5514.0 5598.4 5435.8 5489.7 5533.2 5545.5 5547.9 03:26:26 INFO - PROCESS | 7351 | 03:26:26 INFO - PROCESS | 7351 | [#1] ext.html Cycles:180 Average:65486.66 Median:39889.61 stddev:136820.06 (343.0%) stddev-sans-first:137116.98 03:26:26 INFO - PROCESS | 7351 | Values: 538.5 574.2 603.5 605.6 609.3 33265.2 34071.3 34071.5 34288.0 34313.3 35385.6 44096.6 45468.8 45607.8 49010.3 8778.1 8925.2 8936.2 8939.3 8943.9 8813.1 8896.8 8899.3 8903.2 8907.6 8155.6 8355.8 10591.4 10847.3 10871.8 10803.3 10868.4 10871.0 10875.8 10879.8 10549.1 10603.3 10608.3 10616.9 10618.8 41770.4 41981.0 42050.4 42069.9 42098.4 3457.7 3464.1 3501.5 3593.9 3677.7 30946.2 32170.0 32206.4 32252.5 33021.3 4056.1 4301.2 4339.3 4461.6 4506.1 334560.0 334726.0 361532.0 376266.0 377001.0 62648.0 63971.7 64030.5 64041.7 64092.0 66410.7 67042.7 67273.7 67400.0 67624.0 16092.3 16257.3 16276.2 16468.8 16482.0 13128.3 13170.1 13284.9 13292.6 13294.2 17224.3 17601.3 19914.3 20031.0 20215.7 7248.6 7435.5 7603.9 7693.5 7718.0 969.2 987.8 998.4 1045.1 1120.3 31845.2 32228.4 32270.0 32475.2 32888.8 1049.2 1070.3 1070.7 1107.7 1223.4 16042.5 16528.8 16600.5 16736.5 16852.7 564525.0 564825.0 569300.0 569368.0 570339.1 51100.5 51974.5 56457.4 57900.0 59285.7 1326.8 1365.5 1371.5 1378.0 1382.4 31045.5 33663.0 33688.6 33703.2 34088.8 51855.2 52835.5 52891.5 52903.0 52952.5 502507.0 506074.0 514166.0 515164.0 812231.0 28256.9 42404.0 42469.8 42864.1 43358.0 44352.0 46822.0 46985.5 47244.5 47735.0 38706.6 39762.6 40364.0 40474.6 41381.4 38664.6 39811.2 39968.0 40404.8 41544.4 41083.4 41552.6 41933.8 42432.2 42445.0 33313.2 35770.6 36212.3 36521.5 36800.0 28136.3 28529.4 28610.0 28617.9 28741.1 03:26:26 INFO - PROCESS | 7351 | 03:26:26 INFO - PROCESS | 7351 | [#2] jquery.html Cycles:180 Average:27683.34 Median:388959.50 stddev:75720.71 (19.5%) stddev-sans-first:75905.38 03:26:26 INFO - PROCESS | 7351 | Values: 386.2 393.8 403.5 405.3 425.4 13410.5 15443.2 18987.4 19406.7 19767.3 18188.9 18385.2 18605.8 18908.7 18930.8 5584.7 5662.3 5898.8 5910.7 5910.8 5696.7 5868.5 5875.7 5877.5 5880.1 3834.5 4014.4 5623.3 5874.1 5907.1 5833.6 5876.2 5966.4 5969.0 5976.6 5687.8 5724.1 5732.0 5732.2 5733.3 13737.8 15828.4 21536.8 21914.9 22068.1 2140.9 2172.9 2217.7 2248.5 2284.2 9803.8 9951.5 9968.7 11895.5 14322.0 1848.9 1926.8 1933.2 1947.9 1975.9 78938.6 84794.6 85246.6 87911.0 89558.0 10521.5 10597.2 10799.4 11033.2 11189.9 15661.8 15687.5 15704.7 15714.5 15745.7 7790.5 8045.8 8194.8 8271.8 8275.8 7546.8 7586.6 7637.7 7761.8 7803.8 4543.6 4634.0 4650.7 4748.8 4799.1 1977.2 1987.9 1999.9 2014.6 2031.3 863.8 919.0 956.8 992.2 1004.0 17765.9 18640.3 18996.9 19076.6 19333.0 966.6 971.3 989.9 994.5 995.0 10030.0 10481.2 10487.2 10517.9 10576.7 388932.0 388987.0 390890.0 530031.0 554146.0 84485.0 90668.5 92026.0 94177.5 96441.0 998.4 1032.1 1045.5 1053.2 1065.1 16460.4 16670.7 16849.5 17065.5 17759.0 29939.4 41514.6 42598.4 42842.0 43735.0 55810.7 58452.1 58530.4 59927.4 62075.4 7679.4 8093.8 8159.2 8458.4 8615.7 12152.9 12627.4 12663.4 12747.8 12804.7 10686.8 10921.4 11019.3 11185.3 11261.2 11076.1 11091.0 11155.2 11212.3 11296.7 10590.8 10762.8 11348.8 11431.0 11600.2 7213.0 7543.8 7726.3 8200.9 8522.2 10173.4 10735.4 11047.8 11149.6 11449.8 03:26:26 INFO - PROCESS | 7351 | 03:26:26 INFO - PROCESS | 7351 | [#3] mootools.html Cycles:180 Average:5713.12 Median:4948.10 stddev:3285.48 (66.4%) stddev-sans-first:3278.31 03:26:26 INFO - PROCESS | 7351 | Values: 1346.5 1391.3 1474.0 1572.9 1740.2 7646.8 8504.8 8797.2 8809.3 9046.1 8803.3 8874.3 8889.5 8889.8 8894.1 2327.2 2333.3 2335.7 2356.2 2359.3 2289.5 2334.2 2336.7 2340.0 2346.2 2296.3 2300.7 2311.4 2333.5 2354.6 2243.5 2259.6 2268.6 2291.4 2292.5 2228.7 2229.1 2232.4 2237.8 2268.0 8728.0 8853.0 8923.6 8925.9 8934.4 5185.6 5324.6 5352.7 5379.5 5409.6 3395.3 3399.9 3437.4 3486.1 3500.6 1084.2 1093.7 1107.7 1109.5 1135.1 12218.9 12238.4 12267.1 12340.3 12350.4 4176.0 4309.2 4440.4 4470.5 4475.9 9465.9 9485.4 9492.8 9502.4 9505.7 5116.1 5117.5 5119.6 5122.6 5123.6 4267.6 4378.8 4713.7 4789.5 4823.4 3664.0 3745.5 3816.9 3846.3 3864.9 1156.7 1163.5 1169.4 1177.5 1189.3 842.5 930.0 947.7 953.0 987.4 5642.9 5707.6 5825.8 5840.1 6114.6 448.2 457.4 457.7 458.2 458.5 3830.7 3920.4 3962.8 4012.9 4072.2 10590.2 10924.2 10943.3 10946.4 11003.6 10840.4 10850.2 10868.9 10878.6 10882.1 7691.7 7948.8 8024.5 8038.8 8121.1 5819.4 5907.5 5916.3 5937.1 6082.8 9518.8 9681.5 9781.5 9946.6 9994.0 9617.1 10044.4 10055.8 10150.0 10156.7 7493.8 7709.7 7775.5 7805.3 7921.8 8548.5 8592.5 8598.1 8612.7 8614.0 7625.3 7727.9 7777.7 7837.9 8033.7 7530.8 7609.0 7668.5 7675.3 7687.2 7045.9 7125.3 7132.1 7135.9 7141.3 4920.6 4942.5 4989.5 5083.4 5334.6 4953.7 5017.7 5182.3 5191.3 5229.1 03:26:26 INFO - PROCESS | 7351 | 03:26:26 INFO - PROCESS | 7351 | [#4] prototype.html Cycles:180 Average:4428.71 Median:4886.17 stddev:1252.47 (25.6%) stddev-sans-first:1217.42 03:26:26 INFO - PROCESS | 7351 | Values: 319.6 328.1 334.4 340.7 344.5 5079.5 5178.4 5201.5 5217.6 5254.8 5024.4 5094.9 5105.3 5121.9 5137.2 4099.0 4101.2 4103.3 4112.2 4149.7 3775.8 3915.7 4123.3 4142.9 4173.5 4025.7 4103.3 4113.1 4113.3 4114.6 4080.0 4104.5 4108.5 4110.5 4117.5 3690.0 3704.6 3710.2 3714.3 3723.1 4929.9 5044.0 5044.3 5055.3 5072.7 4652.0 4658.5 4658.6 4660.0 4663.0 5386.7 5403.9 5404.3 5409.5 5420.9 3802.8 3920.5 3956.1 3990.8 4009.5 5594.2 5650.7 5678.2 5681.8 5695.4 4161.6 4194.8 4216.3 4221.9 4223.8 3998.4 4175.4 4176.0 4211.1 4273.8 4697.6 4701.5 4703.2 4721.0 4722.6 5409.8 5448.9 5464.9 5536.7 5544.6 1403.8 1444.8 1448.9 1456.7 1461.1 917.4 947.6 962.0 964.4 971.2 4618.7 4632.9 4702.1 4710.1 4728.5 4843.1 4846.0 4872.6 4888.5 4912.0 4493.3 4723.4 4738.3 4738.6 4752.0 2588.1 2613.0 2628.4 2643.7 2646.4 5124.5 5137.6 5153.3 5153.9 5174.6 4851.0 4976.8 4997.6 5012.4 5026.3 5011.8 5066.5 5110.6 5120.3 5136.9 4866.7 4883.9 4926.2 4943.2 4975.7 4554.4 4824.6 4846.5 4859.9 4876.3 4980.3 4993.8 4999.8 5012.8 5063.9 3750.5 3771.0 3774.4 3837.6 3938.6 5366.8 5486.4 5527.9 5532.3 5535.4 5370.6 5387.6 5398.7 5399.5 5412.6 5200.4 5392.1 5404.6 5443.9 5451.5 5375.4 5412.2 5414.9 5442.9 5451.0 5442.5 5492.0 5500.5 5513.0 5532.7 5214.8 5335.9 5359.9 5385.2 5392.4 03:26:26 INFO - PROCESS | 7351 | 03:26:26 INFO - PROCESS | 7351 | [#5] yui.html Cycles:180 Average:20776.85 Median:4617.21 stddev:30115.42 (652.2%) stddev-sans-first:30162.13 03:26:26 INFO - PROCESS | 7351 | Values: 687.9 727.3 739.3 752.4 766.3 15784.4 16737.2 16750.7 16761.2 16772.2 15205.6 15330.1 15388.2 15445.2 15492.7 650.0 789.5 794.6 799.5 801.1 663.9 671.4 671.5 671.6 779.4 852.9 858.3 859.5 860.0 860.0 853.8 854.2 854.8 855.3 856.5 501.6 509.8 622.7 625.4 625.9 14403.3 14866.1 14871.3 15445.5 15478.5 14910.3 15275.4 15508.1 15659.2 15985.4 11925.6 11955.1 12304.5 12483.3 12529.5 3817.6 3853.0 3908.9 3978.4 4096.9 81694.0 81873.6 82014.0 83091.0 83967.6 11148.6 11167.9 11270.7 11286.3 11381.4 20302.3 23382.3 23461.0 23469.9 23488.5 8528.5 8530.0 8566.5 8581.4 8696.3 4537.6 4580.5 4642.6 4686.2 4907.4 3656.9 3760.9 3792.0 3793.7 3801.9 653.5 663.5 668.4 680.0 686.4 563.3 602.6 670.7 676.2 681.1 9123.5 9443.8 9597.5 9709.2 9848.9 615.8 685.3 685.8 699.5 712.2 4591.8 4786.3 4787.0 4842.6 4846.4 75145.0 81590.0 120772.0 127402.0 128575.0 105757.5 108913.5 109007.5 109643.9 111041.4 87350.6 91282.0 92863.0 92912.5 95850.0 8740.9 9147.3 9159.0 9236.4 9402.5 54813.0 55273.4 55277.5 55461.7 56411.7 47461.5 48206.0 48629.8 52320.7 53540.5 10820.2 11465.2 11587.9 12233.5 12359.4 14562.5 14938.6 15013.2 15042.4 15291.2 13643.9 13891.0 14181.9 14940.3 14966.7 13708.5 13727.8 14455.6 14606.3 14614.3 13686.2 13758.2 14309.0 14662.0 14743.0 10904.2 11321.3 11462.3 11515.0 11990.9 11458.5 11820.8 11838.9 12095.9 12105.3 03:26:26 INFO - PROCESS | 7351 | -------- Summary: end -------- 03:26:26 INFO - PROCESS | 7351 | 03:26:27 INFO - TEST-INFO | 7351: exit 0 03:26:27 INFO - TEST-OK | dromaeo_css | took 1118048ms 03:26:27 INFO - TEST-START | kraken 03:26:27 INFO - operating with platform_type : linux_ 03:26:27 INFO - Initialising browser for kraken test... 03:26:27 INFO - TEST-INFO | started process 7673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcdwq8R/profile http://localhost:45842/getInfo.html) 03:26:31 INFO - PROCESS | 7673 | __metrics Screen width/height:1600/1200 03:26:31 INFO - PROCESS | 7673 | colorDepth:24 03:26:31 INFO - PROCESS | 7673 | Browser inner width/height: 1024/697 03:26:31 INFO - PROCESS | 7673 | __metrics 03:26:32 INFO - PROCESS | 7673 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:26:32 INFO - PROCESS | 7673 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:26:32 INFO - PROCESS | 7673 | console.error: PushService: 03:26:32 INFO - PROCESS | 7673 | stateChangeProcessEnqueue: Error transitioning state 03:26:32 INFO - PROCESS | 7673 | UnknownError 03:26:33 INFO - TEST-INFO | 7673: exit 0 03:26:33 INFO - Browser initialized. 03:26:33 INFO - Running cycle 1/1 for kraken test... 03:26:33 INFO - TEST-INFO | started process 7755 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcdwq8R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:45 INFO - PROCESS | 7755 | RSS: Main: 173703168 03:26:45 INFO - PROCESS | 7755 | 03:26:48 INFO - PROCESS | 7755 | Cycle 1(1): loaded http://localhost:45842/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45842/tests/kraken/driver.html?testName=audio-beat-detection) 03:26:49 INFO - PROCESS | 7755 | RSS: Main: 232701952 03:26:49 INFO - PROCESS | 7755 | 03:26:51 INFO - PROCESS | 7755 | Cycle 1(1): loaded http://localhost:45842/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45842/tests/kraken/driver.html?testName=audio-dft) 03:26:52 INFO - PROCESS | 7755 | RSS: Main: 217542656 03:26:52 INFO - PROCESS | 7755 | 03:26:55 INFO - PROCESS | 7755 | Cycle 1(1): loaded http://localhost:45842/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45842/tests/kraken/driver.html?testName=audio-fft) 03:26:56 INFO - PROCESS | 7755 | RSS: Main: 298565632 03:26:56 INFO - PROCESS | 7755 | 03:26:58 INFO - PROCESS | 7755 | Cycle 1(1): loaded http://localhost:45842/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45842/tests/kraken/driver.html?testName=audio-oscillator) 03:26:58 INFO - PROCESS | 7755 | RSS: Main: 208662528 03:26:58 INFO - PROCESS | 7755 | 03:27:01 INFO - PROCESS | 7755 | Cycle 1(1): loaded http://localhost:45842/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45842/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:27:01 INFO - PROCESS | 7755 | RSS: Main: 212729856 03:27:01 INFO - PROCESS | 7755 | 03:27:04 INFO - PROCESS | 7755 | Cycle 1(1): loaded http://localhost:45842/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45842/tests/kraken/driver.html?testName=imaging-darkroom) 03:27:05 INFO - PROCESS | 7755 | RSS: Main: 249393152 03:27:05 INFO - PROCESS | 7755 | 03:27:08 INFO - PROCESS | 7755 | Cycle 1(1): loaded http://localhost:45842/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45842/tests/kraken/driver.html?testName=imaging-desaturate) 03:27:09 INFO - PROCESS | 7755 | RSS: Main: 247705600 03:27:09 INFO - PROCESS | 7755 | 03:27:11 INFO - PROCESS | 7755 | Cycle 1(1): loaded http://localhost:45842/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45842/tests/kraken/driver.html?testName=json-parse-financial) 03:27:12 INFO - PROCESS | 7755 | RSS: Main: 247549952 03:27:12 INFO - PROCESS | 7755 | 03:27:13 INFO - PROCESS | 7755 | Cycle 1(1): loaded http://localhost:45842/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45842/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:27:14 INFO - PROCESS | 7755 | RSS: Main: 208920576 03:27:14 INFO - PROCESS | 7755 | 03:27:16 INFO - PROCESS | 7755 | Cycle 1(1): loaded http://localhost:45842/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45842/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:27:16 INFO - PROCESS | 7755 | RSS: Main: 217231360 03:27:16 INFO - PROCESS | 7755 | 03:27:18 INFO - PROCESS | 7755 | Cycle 1(1): loaded http://localhost:45842/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45842/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:27:19 INFO - PROCESS | 7755 | RSS: Main: 226934784 03:27:19 INFO - PROCESS | 7755 | 03:27:22 INFO - PROCESS | 7755 | Cycle 1(1): loaded http://localhost:45842/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45842/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:27:23 INFO - PROCESS | 7755 | RSS: Main: 232493056 03:27:23 INFO - PROCESS | 7755 | 03:27:25 INFO - PROCESS | 7755 | Cycle 1(1): loaded http://localhost:45842/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45842/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:27:26 INFO - PROCESS | 7755 | RSS: Main: 232849408 03:27:26 INFO - PROCESS | 7755 | 03:27:28 INFO - PROCESS | 7755 | Cycle 1(1): loaded http://localhost:45842/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45842/tests/kraken/driver.html?testName=ai-astar) 03:27:28 INFO - PROCESS | 7755 | RSS: Main: 283189248 03:27:28 INFO - PROCESS | 7755 | 03:27:28 INFO - PROCESS | 7755 | __start_tp_report 03:27:28 INFO - PROCESS | 7755 | _x_x_mozilla_page_load 03:27:28 INFO - PROCESS | 7755 | _x_x_mozilla_page_load_details 03:27:28 INFO - PROCESS | 7755 | |i|pagename|runs| 03:27:28 INFO - PROCESS | 7755 | |0;ai-astar;110;111;111;110;112;110;111;113;110;110 03:27:28 INFO - PROCESS | 7755 | |1;audio-beat-detection;149;123;123;167;122;127;121;120;146;123 03:27:28 INFO - PROCESS | 7755 | |2;audio-dft;161;162;160;161;162;163;164;162;162;162 03:27:28 INFO - PROCESS | 7755 | |3;audio-fft;74;75;76;110;77;77;76;75;105;75 03:27:28 INFO - PROCESS | 7755 | |4;audio-oscillator;83;82;115;84;83;84;104;82;82;112 03:27:28 INFO - PROCESS | 7755 | |5;imaging-gaussian-blur;117;117;117;117;117;116;118;117;118;117 03:27:28 INFO - PROCESS | 7755 | |6;imaging-darkroom;146;145;146;145;146;146;146;145;147;145 03:27:28 INFO - PROCESS | 7755 | |7;imaging-desaturate;95;96;96;96;95;95;96;96;95;96 03:27:28 INFO - PROCESS | 7755 | |8;json-parse-financial;55;53;52;53;54;54;54;54;54;54 03:27:28 INFO - PROCESS | 7755 | |9;json-stringify-tinderbox;62;61;61;61;62;61;61;61;61;62 03:27:28 INFO - PROCESS | 7755 | |10;stanford-crypto-aes;80;82;79;82;80;87;79;79;79;80 03:27:28 INFO - PROCESS | 7755 | |11;stanford-crypto-ccm;149;135;131;128;132;130;132;140;163;139 03:27:28 INFO - PROCESS | 7755 | |12;stanford-crypto-pbkdf2;167;174;168;166;168;163;164;169;165;162 03:27:28 INFO - PROCESS | 7755 | |13;stanford-crypto-sha256-iterative;67;66;66;65;66;66;66;67;69;65 03:27:28 INFO - PROCESS | 7755 | __end_tp_report 03:27:28 INFO - PROCESS | 7755 | __start_cc_report 03:27:28 INFO - PROCESS | 7755 | _x_x_mozilla_cycle_collect,1684 03:27:28 INFO - PROCESS | 7755 | __end_cc_report 03:27:28 INFO - PROCESS | 7755 | __startTimestamp1476440848360__endTimestamp 03:27:28 INFO - PROCESS | 7755 | 03:27:28 INFO - PROCESS | 7755 | ------- Summary: start ------- 03:27:28 INFO - PROCESS | 7755 | Number of tests: 14 03:27:28 INFO - PROCESS | 7755 | 03:27:28 INFO - PROCESS | 7755 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:1.03 (0.9%) stddev-sans-first:1.05 03:27:28 INFO - PROCESS | 7755 | Values: 110.0 111.0 111.0 110.0 112.0 110.0 111.0 113.0 110.0 110.0 03:27:28 INFO - PROCESS | 7755 | 03:27:28 INFO - PROCESS | 7755 | [#1] audio-beat-detection Cycles:10 Average:132.10 Median:125.00 stddev:16.13 (12.9%) stddev-sans-first:15.91 03:27:28 INFO - PROCESS | 7755 | Values: 149.0 123.0 123.0 167.0 122.0 127.0 121.0 120.0 146.0 123.0 03:27:28 INFO - PROCESS | 7755 | 03:27:28 INFO - PROCESS | 7755 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 03:27:28 INFO - PROCESS | 7755 | Values: 161.0 162.0 160.0 161.0 162.0 163.0 164.0 162.0 162.0 162.0 03:27:28 INFO - PROCESS | 7755 | 03:27:28 INFO - PROCESS | 7755 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.50 stddev:13.52 (17.9%) stddev-sans-first:14.03 03:27:28 INFO - PROCESS | 7755 | Values: 74.0 75.0 76.0 110.0 77.0 77.0 76.0 75.0 105.0 75.0 03:27:28 INFO - PROCESS | 7755 | 03:27:28 INFO - PROCESS | 7755 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:82.50 stddev:13.56 (16.4%) stddev-sans-first:14.06 03:27:28 INFO - PROCESS | 7755 | Values: 83.0 82.0 115.0 84.0 83.0 84.0 104.0 82.0 82.0 112.0 03:27:28 INFO - PROCESS | 7755 | 03:27:28 INFO - PROCESS | 7755 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 03:27:28 INFO - PROCESS | 7755 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 118.0 117.0 118.0 117.0 03:27:28 INFO - PROCESS | 7755 | 03:27:28 INFO - PROCESS | 7755 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 03:27:28 INFO - PROCESS | 7755 | Values: 146.0 145.0 146.0 145.0 146.0 146.0 146.0 145.0 147.0 145.0 03:27:28 INFO - PROCESS | 7755 | 03:27:28 INFO - PROCESS | 7755 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 03:27:28 INFO - PROCESS | 7755 | Values: 95.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 96.0 03:27:28 INFO - PROCESS | 7755 | 03:27:28 INFO - PROCESS | 7755 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.73 03:27:28 INFO - PROCESS | 7755 | Values: 55.0 53.0 52.0 53.0 54.0 54.0 54.0 54.0 54.0 54.0 03:27:28 INFO - PROCESS | 7755 | 03:27:28 INFO - PROCESS | 7755 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 03:27:28 INFO - PROCESS | 7755 | Values: 62.0 61.0 61.0 61.0 62.0 61.0 61.0 61.0 61.0 62.0 03:27:28 INFO - PROCESS | 7755 | 03:27:28 INFO - PROCESS | 7755 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:2.50 (3.1%) stddev-sans-first:2.64 03:27:28 INFO - PROCESS | 7755 | Values: 80.0 82.0 79.0 82.0 80.0 87.0 79.0 79.0 79.0 80.0 03:27:28 INFO - PROCESS | 7755 | 03:27:28 INFO - PROCESS | 7755 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:137.00 stddev:10.77 (7.9%) stddev-sans-first:10.65 03:27:28 INFO - PROCESS | 7755 | Values: 149.0 135.0 131.0 128.0 132.0 130.0 132.0 140.0 163.0 139.0 03:27:28 INFO - PROCESS | 7755 | 03:27:28 INFO - PROCESS | 7755 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.60 Median:167.50 stddev:3.47 (2.1%) stddev-sans-first:3.68 03:27:28 INFO - PROCESS | 7755 | Values: 167.0 174.0 168.0 166.0 168.0 163.0 164.0 169.0 165.0 162.0 03:27:28 INFO - PROCESS | 7755 | 03:27:28 INFO - PROCESS | 7755 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:1.16 (1.8%) stddev-sans-first:1.20 03:27:28 INFO - PROCESS | 7755 | Values: 67.0 66.0 66.0 65.0 66.0 66.0 66.0 67.0 69.0 65.0 03:27:28 INFO - PROCESS | 7755 | -------- Summary: end -------- 03:27:28 INFO - PROCESS | 7755 | 03:27:29 INFO - TEST-INFO | 7755: exit 0 03:27:29 INFO - TEST-OK | kraken | took 61798ms 03:27:29 INFO - SUITE-END | took 1179s 03:27:30 INFO - Completed test suite (00:19:40) 03:27:30 INFO - javascript benchmark 03:27:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2991.341904780948, 3018.8641511131996, 3026.4249792539417, 3043.376107897881, 3050.8474576271183, 5125.974370128153, 5173.560247378968, 5209.635325527214, 5327.600429967753, 5330.973345133274, 5241.056609810233, 5250.422453530108, 5260.0268950244235, 5270.683758974455, 5274.367075950881, 4741.265103908891, 4790.449098353682, 4810.326554282386, 4894.167991441445, 4915.139850526161, 4806.0, 4809.446913604946, 4813.0, 4873.049755297719, 4875.536824001714, 4144.896377590554, 4808.903821923559, 4843.806247750086, 4848.0, 4909.656324057318, 4825.1555977703765, 4836.202026665596, 4842.757862106881, 4899.58353539946, 4912.263160525949, 4665.346851440801, 4703.600193983515, 4709.034647897173, 4723.126221649006, 4753.786079626425, 5167.0957582422925, 5167.457416971239, 5194.92207616886, 5245.239440281138, 5288.550473209782, 5581.469760372758, 5607.327120745536, 5607.467290607386, 5627.80302689408, 5691.231683722686, 5425.213344065128, 5486.835394938158, 5508.862278443031, 5665.178549110397, 5682.346530149044, 5167.793288268503, 5175.81884634036, 5202.08963431398, 5203.505666961632, 5264.236685680593, 5655.6606603603095, 5664.603477756517, 5667.603267771216, 5668.489835914787, 5671.943280567141, 5346.358436987586, 5379.462053794589, 5394.757235924393, 5541.806036788693, 5589.608727389043, 5518.53092487135, 5555.111182210827, 5556.527695145877, 5614.1859430382365, 5618.634788738719, 5546.445355464502, 5550.389457159709, 5551.306086739158, 5552.167174923794, 5618.91571626426, 5405.297311349578, 5424.267723857308, 5560.138178582326, 5565.471280228372, 5569.582281328917, 4303.634191093792, 4305.74165550068, 4306.074194048295, 4306.375575541591, 4308.74147551148, 3868.0, 3872.0707030313088, 3884.6115388461494, 3891.6497515223764, 3906.0430194602504, 5313.415524292324, 5319.202119682079, 5321.175217841241, 5322.361316642027, 5323.547498462596, 5582.33012038558, 5596.496315331639, 5602.0, 5604.747786349624, 5608.242887210256, 5362.115250983622, 5382.892342153135, 5384.111621582473, 5384.434634363335, 5387.838364849061, 4710.26990816424, 4820.0, 4822.638302127354, 4823.734694591831, 4826.469088400273, 5656.0950247960955, 5746.942530574641, 5778.422157784272, 5786.421357864264, 5789.913151302734, 5549.611527193058, 5560.777568897199, 5563.415841336601, 5565.888682226414, 5628.577856660685, 5679.432056794288, 5726.341470730919, 5728.054870946247, 5817.272840894888, 5847.356790752929, 5526.917096243479, 5543.584231182596, 5553.222548843246, 5590.357108932362, 5612.326520817528, 5613.719314034363, 5622.0, 5624.35319938196, 5630.042892708331, 5630.380658127685, 5286.286351342519, 5355.625106242525, 5425.565954723692, 5515.117581186991, 5519.8128742885565, 5424.783008679767, 5493.807716729895, 5497.47773961473, 5544.695041772741, 5556.91664625039, 5458.235846981346, 5461.808836690697, 5464.672119672832, 5465.59008074388, 5468.343798744176, 5348.679079255257, 5409.6213265071065, 5495.670259784426, 5513.972430137824, 5598.412166722598, 5435.755391007335, 5489.670619762827, 5533.2253484513, 5545.500904918576, 5547.916781248366], "value": 5166.286107226425, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.4738661599396, 574.2133277409947, 603.4508597176567, 605.6456972670993, 609.3266940031268, 33265.16837079074, 34071.318573628516, 34071.488927666105, 34288.0, 34313.313733725314, 35385.64614353856, 44096.55903440965, 45468.77265613667, 45607.77196114023, 49010.26484602734, 8778.122187781219, 8925.241354484844, 8936.240419564345, 8939.28485721144, 8943.865842012376, 8813.074627164151, 8896.822063558724, 8899.28805695546, 8903.198712115909, 8907.554622268894, 8155.551444670541, 8355.791105222357, 10591.364518128898, 10847.294925829796, 10871.83692244617, 10803.297785643908, 10868.402237876913, 10871.0, 10875.782484350308, 10879.83680244797, 10549.10332621728, 10603.257771955967, 10608.257421980465, 10616.946915265451, 10618.840717389245, 41770.373444398356, 41981.0, 42050.369244461355, 42069.89986451947, 42098.36852447216, 3457.7233821294235, 3464.133966508373, 3501.492283618861, 3593.9101522461888, 3677.687396571295, 30946.226344341347, 32170.0, 32206.35587288241, 32252.516212256836, 33021.3395732084, 4056.0831303137215, 4301.1827752727195, 4339.349097635349, 4461.643068554507, 4506.121306345264, 334560.0, 334726.0, 361532.0, 376266.0, 377000.99999999726, 62648.0, 63971.680141599, 64030.51404975985, 64041.67979160167, 64092.0, 66410.66794665996, 67042.66478667673, 67273.66363168153, 67400.0, 67624.0, 16092.275847586887, 16257.268422920997, 16276.186190690418, 16468.83531164697, 16482.0, 13128.343582821011, 13170.143940643828, 13284.867151328557, 13292.601221963356, 13294.202347858965, 17224.311027559008, 17601.295948162187, 19914.302999394953, 20031.0, 20215.696764548542, 7248.565086094851, 7435.4533770674325, 7603.885941710879, 7693.461457698019, 7717.961410193026, 969.2439896880445, 987.7728122531714, 998.381003777648, 1045.0646671229208, 1120.2830188679252, 31845.248511331636, 32228.35543289168, 32270.0, 32475.18021215524, 32888.835555822545, 1049.223574554824, 1070.3417398300146, 1070.6734445994045, 1107.6732363952492, 1223.3944197622234, 16042.518724438285, 16528.83471165273, 16600.461206575816, 16736.497905062868, 16852.662946740995, 564525.0, 564825.0, 569300.0, 569368.0, 570339.1483042558, 51100.488995109576, 51974.48025519696, 56457.43542564522, 57900.0, 59285.70357148186, 1326.7611829870716, 1365.5015919189623, 1371.5062577471901, 1377.9724405512034, 1382.3710211853584, 31045.534316985715, 33663.0, 33688.62047933753, 33703.15742106369, 34088.82955585206, 51855.2221716667, 52835.471645283054, 52891.47108528866, 52903.0, 52952.47047529475, 502507.0, 506074.0, 514166.0, 515164.0, 812231.0, 28256.85871570629, 42404.0, 42469.787651061546, 42864.142717146104, 43358.0, 44352.0, 46822.0, 46985.53014469812, 47244.527554725384, 47735.0, 38706.6129338703, 39762.60237397589, 40364.0, 40474.59525404708, 41381.37927931023, 38664.6133538661, 39811.220977221536, 39968.0, 40404.79797600993, 41544.37683434811, 41083.383749243185, 41552.58447415487, 41933.79033104815, 42432.15135697207, 42445.0, 33313.167170820925, 35770.64229357673, 36212.27575448424, 36521.452178216816, 36800.0, 28136.29659258535, 28529.42941141207, 28610.0, 28617.856910715313, 28741.137765867057], "value": 20736.688317178116, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.22947220295515, 393.8385262042565, 403.45130622353594, 405.33525018968885, 425.4086819321144, 13410.530631427902, 15443.15062671554, 18987.430377088676, 19406.70889936652, 19767.30814421492, 18188.909055454704, 18385.242213667956, 18605.81394186058, 18908.71636925447, 18930.810691893075, 5584.664920104787, 5662.348829884554, 5898.7640494380175, 5910.704464776765, 5910.763569457216, 5696.658200507962, 5868.501177399926, 5875.735591898375, 5877.471027607515, 5880.147378630096, 3834.5206849143856, 4014.4179094031347, 5623.26897503324, 5874.148248503964, 5907.0548712206055, 5833.649981001154, 5876.2067120938555, 5966.433188847074, 5968.97015514924, 5976.5517586180995, 5687.810193075696, 5724.112762521774, 5731.971340143273, 5732.197492351074, 5733.283339582552, 13737.793933091012, 15828.366865325374, 21536.78463215379, 21914.890425547772, 22068.117275308967, 2140.892955352226, 2172.891355432222, 2217.733871935362, 2248.5278091600785, 2284.1776960294283, 9803.754906127333, 9951.502424878727, 9968.651097211563, 11895.464704088337, 14322.0, 1848.92604295828, 1926.8362189213933, 1933.168737442899, 1947.8928658923753, 1975.940721778349, 78938.6053069731, 84794.57602711947, 85246.57376713138, 87911.0, 89557.99999999935, 10521.52653130611, 10597.205209609156, 10799.352038877692, 11033.227674062899, 11189.929862975376, 15661.843381566267, 15687.450939217073, 15704.685906281811, 15714.528564143095, 15745.68508629844, 7790.493617914817, 8045.758627241192, 8194.836103277901, 8271.793205169919, 8275.793105172299, 7546.849063018709, 7586.582737949356, 7637.732679356196, 7761.8447631047065, 7803.843923121506, 4543.5910768031035, 4634.0, 4650.67445278834, 4748.810047598057, 4799.112164249625, 1977.2486455146952, 1987.930422435208, 1999.8600097993292, 2014.617222727677, 2031.2890488329263, 863.7538301584018, 918.9678361257323, 956.7942892278194, 992.1764935103846, 1003.9849402258972, 17765.911170444324, 18640.254389824528, 18996.905015474833, 19076.61846763057, 19333.0, 966.5988614724811, 971.2812518736084, 989.9356541824758, 994.5077186792583, 994.9557135480778, 10030.0, 10481.213908956859, 10487.161027117812, 10517.9474102629, 10576.682699519026, 388932.0, 388987.0, 390890.0, 530031.0, 554146.0, 84485.0, 90668.54665726628, 92026.0, 94177.529112354, 96441.0, 998.4159266828841, 1032.0969151992008, 1045.529511719714, 1053.2311412668794, 1065.0893486069454, 16460.42388516396, 16670.74993875117, 16849.494515164566, 17065.488035358958, 17759.0, 29939.401211976074, 41514.58485415107, 42598.36102458404, 42842.0, 43735.0, 55810.720946395006, 58452.123218152614, 58530.4146958542, 59927.400725992185, 62075.37924620696, 7679.424043196671, 8093.757187284391, 8159.224873636995, 8458.40791144614, 8615.6984505542, 12152.939235303767, 12627.431765570755, 12663.366831658195, 12747.808782868078, 12804.743905121659, 10686.786264274826, 10921.399323037309, 11019.283746556768, 11185.272957257752, 11261.21171517986, 11076.107933263535, 11091.0, 11155.219134660496, 11212.327260364404, 11296.717582060186, 10590.8411373831, 10762.838557421488, 11348.829767553658, 11431.0, 11600.18798684084, 7213.0, 7543.762502681347, 7726.343260822893, 8200.917990820015, 8522.190391912758, 10173.389596624227, 10735.355878647306, 11047.779044419227, 11149.609763658233, 11449.771004580029], "value": 8995.170077240104, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.5421756602752, 1391.2695834686792, 1474.0418727826911, 1572.9292181851815, 1740.1560243282006, 7646.847063058735, 8504.829903401927, 8797.208251257385, 8809.251213646832, 9046.140616641425, 8803.251723603486, 8874.290056795457, 8889.466632002084, 8889.822203555941, 8894.110588941103, 2327.208749025331, 2333.3000099970027, 2335.6613291072786, 2356.22244659262, 2359.327591636384, 2289.461976435536, 2334.2297041976108, 2336.707911511061, 2339.9883000584973, 2346.2257455039794, 2296.3455415206668, 2300.7354154272307, 2311.4282288044124, 2333.5449587330477, 2354.5526349993447, 2243.4952135769486, 2259.604569200392, 2268.5576312619046, 2291.427143214205, 2292.541491701658, 2228.6545585434283, 2229.097215627657, 2232.441889527618, 2237.8321625878125, 2267.977320226793, 8727.956360218222, 8852.955735221283, 8923.643054277822, 8925.866112008325, 8934.4192627479, 5185.61107916904, 5324.5740340772645, 5352.678839269656, 5379.462053794589, 5409.594280428983, 3395.303962687668, 3399.8640054397792, 3437.415639341318, 3486.1458942559234, 3500.597431295408, 1084.159776173464, 1093.7265683579105, 1107.6732363952653, 1109.4563663804759, 1135.1486385211092, 12218.877811221952, 12238.388080596023, 12267.079969002361, 12340.259584424874, 12350.382480876011, 4175.958240417618, 4309.159713855768, 4440.445843954654, 4470.530594287618, 4475.888102797456, 9465.905340946503, 9485.430874147572, 9492.762680933032, 9502.429854208769, 9505.66730164441, 5116.130257856174, 5117.488251174853, 5119.59043276537, 5122.590192784568, 5123.6157288202785, 4267.637250833652, 4378.8029538670835, 4713.67004309695, 4789.473157952622, 4823.445303790038, 3663.9633603663624, 3745.513083299208, 3816.904577385588, 3846.3076646203394, 3864.9227015459533, 1156.7281688803125, 1163.4706208675032, 1169.3802284789076, 1177.5172179406402, 1189.2567145534042, 842.5029232752582, 929.9541009778515, 947.7298969793576, 953.046953046953, 987.3927534566191, 5642.915356269659, 5707.600467967202, 5825.79609713658, 5840.1239814027385, 6114.602550834182, 448.1664104765134, 457.38938517079407, 457.66819056184, 458.21873705332996, 458.46588724136006, 3830.731848770615, 3920.3727403615853, 3962.841486340572, 4012.874681122491, 4072.226277007359, 10590.205734569938, 10924.235303528836, 10943.28868623537, 10946.397948112772, 11003.61487347939, 10840.403777792297, 10850.186236032328, 10868.891311086787, 10878.61924832643, 10882.129429645609, 7691.692332306757, 7948.761537153895, 8024.478408903519, 8038.758837234892, 8121.147279535564, 5819.388964158702, 5907.4683278505145, 5916.349201587908, 5937.079752638348, 6082.847928801639, 9518.762030949281, 9681.467519286225, 9781.51092445389, 9946.552405141641, 9993.950030249802, 9617.134457898823, 10044.397336159855, 10055.798884022131, 10150.0, 10156.695299141038, 7493.775186744188, 7709.691612335444, 7775.494592851673, 7805.33654639362, 7921.762347129596, 8548.487090774574, 8592.484450932963, 8598.140185981352, 8612.741617751477, 8613.956930215309, 7625.275598818103, 7727.9227207729455, 7777.650005749641, 7837.941877846418, 8033.718819841278, 7530.774076777706, 7608.96195519041, 7668.539887606761, 7675.270849269311, 7687.154413014676, 7045.894311585228, 7125.251848555827, 7132.144142702701, 7135.928640713734, 7141.321574450419, 4920.630952678635, 4942.5304596063315, 4989.476105009067, 5083.38999320084, 5334.599905007062, 4953.678010929278, 5017.724025178651, 5182.300389447376, 5191.32512773337, 5229.137192363218], "value": 4478.799393515008, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.63880814679425, 328.1402724860865, 334.37471927495585, 340.69167403499836, 344.5004743122473, 5079.542841144296, 5178.446466060181, 5201.479852014797, 5217.556507696846, 5254.81608143715, 5024.422191447985, 5094.949050509494, 5105.285260063594, 5121.923171152435, 5137.178051511759, 4098.959010409888, 4101.200265948141, 4103.322951712964, 4112.218678451085, 4149.688773341996, 3775.7923314217705, 3915.725899187058, 4123.299039163335, 4142.917141657165, 4173.520045194796, 4025.7181997260204, 4103.343465045578, 4113.115680128772, 4113.25961326961, 4114.567970363114, 4080.0, 4104.486939132608, 4108.5275193352845, 4110.4656394668655, 4117.547069822317, 3690.022144131807, 3704.573973992998, 3710.239400922804, 3714.331420344337, 3723.143676954289, 4929.852104436837, 5043.991201759626, 5044.319016932704, 5055.342805435306, 5072.742629529861, 4651.976740116312, 4658.487566367697, 4658.627309815207, 4659.976700116512, 4662.976685116552, 5386.703731294777, 5403.864903377447, 5404.270423492818, 5409.486098820606, 5420.91868621971, 3802.790846503441, 3920.5496564647096, 3956.149427873021, 3990.8204130814183, 4009.51885773709, 5594.2447769551, 5650.660960342351, 5678.160919540189, 5681.829545113653, 5695.373508914016, 4161.625453709181, 4194.832206711759, 4216.2832318505925, 4221.915561688749, 4223.767692776927, 3998.3602623580086, 4175.352820312856, 4176.0, 4211.115665710174, 4273.786310684453, 4697.624190064855, 4701.459332176775, 4703.153432382135, 4720.976395118071, 4722.598579120745, 5409.83770486886, 5448.91826622601, 5464.93433780409, 5536.723163841792, 5544.556435485151, 1403.8245219347582, 1444.7905053767145, 1448.898577099593, 1456.6722487440454, 1461.1379286221181, 917.3899356927702, 947.6114792934864, 961.9995204986735, 964.4213471916934, 971.2424309038961, 4618.65360097994, 4632.86101416958, 4702.061211742661, 4710.105080034782, 4728.527147285313, 4843.104025755176, 4846.0, 4872.561469467765, 4888.486708895514, 4912.017596480719, 4493.348464472633, 4723.385959825201, 4738.336632871401, 4738.620910327166, 4752.0, 2588.1494731267235, 2612.9869350653125, 2628.395469042131, 2643.7356264373407, 2646.4045589742154, 5124.48755124492, 5137.614678899023, 5153.252778347193, 5153.922691159635, 5174.6377753557645, 4850.95149048505, 4976.751162441863, 4997.600191984705, 5012.373453318335, 5026.321446604735, 5011.819858361624, 5066.493350664904, 5110.565601923878, 5120.308758317654, 5136.948630513647, 4866.7079975201605, 4883.853484395474, 4926.211806111149, 4943.207087995271, 4975.701457912537, 4554.402022402265, 4824.565789079, 4846.539578740014, 4859.878503037452, 4876.317315575751, 4980.32765576657, 4993.750312484434, 4999.77501012448, 5012.77442515095, 5063.924041139459, 3750.4936833527127, 3771.039059689001, 3774.4338349247832, 3837.6162383761402, 3938.5667576565984, 5366.838994830161, 5486.381517452441, 5527.861803454945, 5532.253145825262, 5535.39110697831, 5370.570354371563, 5387.595930305321, 5398.703071331114, 5399.541039011571, 5412.648177868426, 5200.439868039497, 5392.1127605337815, 5404.567634589302, 5443.918341224964, 5451.509364157245, 5375.408705042364, 5412.2410216678945, 5414.891702166014, 5442.891142177214, 5451.018816613047, 5442.537384322377, 5491.956528259618, 5500.50495455395, 5513.0, 5532.695701736282, 5214.817481388285, 5335.919961200662, 5359.946400536101, 5385.165299378603, 5392.406835248198], "value": 4038.51541182859, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.9441737256724, 727.3308556128361, 739.2533541123464, 752.4469514906543, 766.3486036868661, 15784.36862525499, 16737.246823892925, 16750.66498670029, 16761.245743941523, 16772.245248963794, 15205.619859503518, 15330.080195188297, 15388.15365154916, 15445.22773861308, 15492.69014619707, 649.9675016249192, 789.5460110436493, 794.6424109150877, 799.5083023940264, 801.0667572278289, 663.9402453779159, 671.4058058618109, 671.4661843834164, 671.5500614588213, 779.4115442840675, 852.86780549015, 858.2661824140364, 859.4800145911727, 859.9656013759442, 860.0410542245382, 853.799357151069, 854.2098558833086, 854.8375808596347, 855.3029281135854, 856.4775486952954, 501.5962150468871, 509.8444974282842, 622.6824319597038, 625.4214851262564, 625.9092431597438, 14403.279836008263, 14866.108033518023, 14871.33079011447, 15445.459408920746, 15478.535643930587, 14910.329035193443, 15275.38898444061, 15508.14705191214, 15659.21703914811, 15985.360585576564, 11925.565130510802, 11955.08982035928, 12304.507819687202, 12483.251004939733, 12529.498820047187, 3817.5991520890184, 3853.0, 3908.921821563553, 3978.3634618460906, 4096.91806163878, 81694.0, 81873.59063204646, 82014.0, 83091.0, 83967.5801620994, 11148.554057837759, 11167.888321116847, 11270.718232044264, 11286.266392684449, 11381.374024428736, 20302.28941987053, 23382.298531044096, 23461.0, 23469.88265058664, 23488.530229395317, 8528.530930798866, 8529.95735021321, 8566.486010839244, 8581.399302048796, 8696.260817830555, 4537.591616754508, 4580.473245576802, 4642.6444312090125, 4686.203345431285, 4907.435644900811, 3656.926861462756, 3760.8683696071053, 3791.962080379216, 3793.6722147248242, 3801.885943421702, 653.4674240494077, 663.4891133826926, 668.4385116502161, 680.0275605883535, 686.4439803758871, 563.312758434709, 602.6444397805228, 670.7451168556015, 676.1919506190154, 681.0941447874316, 9123.543822808833, 9443.811123777487, 9597.520123993772, 9709.223262139012, 9848.852267215998, 615.7752420366534, 685.256496701075, 685.7874059041714, 699.51034276007, 712.2094475132599, 4591.77041147948, 4786.282057691375, 4787.0, 4842.6368022398465, 4846.442659094178, 75145.0, 81590.0, 120772.0, 127402.0, 128575.0, 105757.47121264499, 108913.45543272233, 109007.45496272467, 109643.90356096496, 111041.44479277552, 87350.56324718335, 91282.0, 92863.0, 92912.53543732374, 95850.04149958551, 8740.91259087401, 9147.313951453534, 9159.0, 9236.353455258337, 9402.52987350616, 54813.0, 55273.44726552683, 55277.52638017336, 55461.72269138628, 56411.71794141003, 47461.52538474571, 48206.0, 48629.75685121552, 52320.738396307774, 53540.46459535355, 10820.18848586375, 11465.19743617972, 11587.942060289644, 12233.510659573873, 12359.44985011308, 14562.490312839, 14938.551843444715, 15013.174275414956, 15042.398304068152, 15291.23543822782, 13643.931780341034, 13891.047482415492, 14181.929090354482, 14940.327685253973, 14966.700665986837, 13708.451661933412, 13727.794083088962, 14455.638609034859, 14606.26968651542, 14614.34235459428, 13686.247256400595, 13758.243296618382, 14309.0, 14662.0, 14743.0, 10904.236703431001, 11321.264117832314, 11462.312261264351, 11515.0, 11990.940045299718, 11458.484368203284, 11820.822687659864, 11838.940805295919, 12095.879041209475, 12105.273683579013], "value": 7534.358952661228, "unit": "score"}], "name": "dromaeo_css", "value": 7129.643348590498, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 111.0, 110.0, 112.0, 110.0, 111.0, 113.0, 110.0, 110.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 123.0, 167.0, 122.0, 127.0, 121.0, 120.0, 146.0, 123.0], "value": 132.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 161.0, 162.0, 163.0, 164.0, 162.0, 162.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 110.0, 77.0, 77.0, 76.0, 75.0, 105.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 115.0, 84.0, 83.0, 84.0, 104.0, 82.0, 82.0, 112.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 147.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 53.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 79.0, 82.0, 80.0, 87.0, 79.0, 79.0, 79.0, 80.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 135.0, 131.0, 128.0, 132.0, 130.0, 132.0, 140.0, 163.0, 139.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 174.0, 168.0, 166.0, 168.0, 163.0, 164.0, 169.0, 165.0, 162.0], "value": 166.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 67.0, 69.0, 65.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1502.8000000000002, "alertThreshold": 2.0}]} 03:27:30 INFO - Return code: 0 03:27:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:27:30 INFO - # TBPL SUCCESS # 03:27:30 INFO - Running post-action listener: _resource_record_post_action 03:27:30 INFO - [mozharness: 2016-10-14 10:27:30.160718Z] Finished run-tests step (success) 03:27:30 INFO - Running post-run listener: _resource_record_post_run 03:27:30 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 404963328; Read time: 16; Write time: 250052 03:27:30 INFO - TinderboxPrint: CPU usage
13.1% 03:27:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:27:30 INFO - TinderboxPrint: I/O write bytes / time
404,963,328 / 250,052 03:27:30 INFO - TinderboxPrint: CPU idle
8,295.0 (86.9%) 03:27:30 INFO - TinderboxPrint: CPU user
1,205.1 (12.6%) 03:27:30 INFO - TinderboxPrint: Swap in / out
0 / 0 03:27:30 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114196480; Read time: 0; Write time: 65692 03:27:30 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 289865728; Read time: 0; Write time: 184196 03:27:30 INFO - Running post-run listener: _upload_blobber_files 03:27:30 INFO - Blob upload gear active. 03:27:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:27:30 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 03:27:30 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'] 03:27:30 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 03:27:31 INFO - (blobuploader) - INFO - Open directory for files ... 03:27:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:27:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:27:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:32 INFO - (blobuploader) - INFO - Done attempting. 03:27:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:27:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:27:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:35 INFO - (blobuploader) - INFO - Done attempting. 03:27:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:27:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:27:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:36 INFO - (blobuploader) - INFO - Done attempting. 03:27:36 INFO - (blobuploader) - INFO - Iteration through files over. 03:27:36 INFO - Return code: 0 03:27:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:27:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:27:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/aa8a9b13ca06a6bd4f0eeeb9920a32a77b9e2691f1c5c2dee4c5624888195b7b58a1eb7e253dc6dc96863f35b8b38eeb4bf5067b4b2ae06d75052854019bd3ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e249ae1d682ea5e5ea0059b466a656022527003fdd4f63656480e79de86fd40cff217655a167ed1393bc2463f859c00116eb4c309a9df8b48d8a920fbc09a542", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a7ec49082dd99f5a32f629a43afa0814ef7844f039d77e39073ffcdc530153414221b32484cc7c806d4d06c6fd2f94ebffe886ad0584195b3114e9499aad1f15"} 03:27:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:27:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:27:36 INFO - Contents: 03:27:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/aa8a9b13ca06a6bd4f0eeeb9920a32a77b9e2691f1c5c2dee4c5624888195b7b58a1eb7e253dc6dc96863f35b8b38eeb4bf5067b4b2ae06d75052854019bd3ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e249ae1d682ea5e5ea0059b466a656022527003fdd4f63656480e79de86fd40cff217655a167ed1393bc2463f859c00116eb4c309a9df8b48d8a920fbc09a542", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a7ec49082dd99f5a32f629a43afa0814ef7844f039d77e39073ffcdc530153414221b32484cc7c806d4d06c6fd2f94ebffe886ad0584195b3114e9499aad1f15"} 03:27:36 INFO - Running post-run listener: copy_logs_to_upload_dir 03:27:36 INFO - Copying logs to upload dir... 03:27:36 INFO - mkdir: /builds/slave/test/build/upload/logs 03:27:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.848525 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-14 03:27:35.531483) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 03:27:35.535136) ========= 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=232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/aa8a9b13ca06a6bd4f0eeeb9920a32a77b9e2691f1c5c2dee4c5624888195b7b58a1eb7e253dc6dc96863f35b8b38eeb4bf5067b4b2ae06d75052854019bd3ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e249ae1d682ea5e5ea0059b466a656022527003fdd4f63656480e79de86fd40cff217655a167ed1393bc2463f859c00116eb4c309a9df8b48d8a920fbc09a542", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a7ec49082dd99f5a32f629a43afa0814ef7844f039d77e39073ffcdc530153414221b32484cc7c806d4d06c6fd2f94ebffe886ad0584195b3114e9499aad1f15"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011408 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476427834/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/aa8a9b13ca06a6bd4f0eeeb9920a32a77b9e2691f1c5c2dee4c5624888195b7b58a1eb7e253dc6dc96863f35b8b38eeb4bf5067b4b2ae06d75052854019bd3ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e249ae1d682ea5e5ea0059b466a656022527003fdd4f63656480e79de86fd40cff217655a167ed1393bc2463f859c00116eb4c309a9df8b48d8a920fbc09a542", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a7ec49082dd99f5a32f629a43afa0814ef7844f039d77e39073ffcdc530153414221b32484cc7c806d4d06c6fd2f94ebffe886ad0584195b3114e9499aad1f15"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 03:27:35.562300) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 03:27:35.562818) ========= 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=232498196343f89f466a4a9a000001c8-1476439616.932927-1967281448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 03:27:35.647557) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 03:27:35.647872) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 03:27:35.648204) ========= ========= Total master_lag: 0.16 =========