builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1476811245.03 results: success (0) buildid: 20161018073001 builduid: 59288635e980483ba11fedd24e469b6d revision: 01ab78dd98805e150b0311cce2351d5b408f3001 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 10:20:45.030951) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 10:20:45.031314) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 10:20:45.031573) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 10:20:45.056219) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 10:20:45.056473) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-18 10:20:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.6M=0.001s 2016-10-18 10:20:45 (19.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100518 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 10:20:45.174741) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 10:20:45.175018) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017190 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 10:20:45.225049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 10:20:45.225356) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 01ab78dd98805e150b0311cce2351d5b408f3001 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 01ab78dd98805e150b0311cce2351d5b408f3001 --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=9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-18 10:20:45,470 truncating revision to first 12 chars 2016-10-18 10:20:45,470 Setting DEBUG logging. 2016-10-18 10:20:45,470 attempt 1/10 2016-10-18 10:20:45,470 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/01ab78dd9880?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-18 10:20:45,766 unpacking tar archive at: mozilla-central-01ab78dd9880/testing/mozharness/ program finished with exit code 0 elapsedTime=0.602217 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 10:20:45.842225) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 10:20:45.842493) ========= script_repo_revision: 01ab78dd98805e150b0311cce2351d5b408f3001 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 10:20:45.842883) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 10:20:45.843141) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 10:20:45.858388) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-18 10:20:45.858647) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:20:46 INFO - MultiFileLogger online at 20161018 10:20:46 in /builds/slave/test 10:20:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:20:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:20:46 INFO - {'append_to_log': False, 10:20:46 INFO - 'base_work_dir': '/builds/slave/test', 10:20:46 INFO - 'blob_upload_branch': 'Firefox', 10:20:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:20:46 INFO - 'branch': 'Firefox', 10:20:46 INFO - 'buildbot_json_path': 'buildprops.json', 10:20:46 INFO - 'config_files': ('talos/linux_config.py',), 10:20:46 INFO - 'default_actions': ('clobber', 10:20:46 INFO - 'read-buildbot-config', 10:20:46 INFO - 'download-and-extract', 10:20:46 INFO - 'populate-webroot', 10:20:46 INFO - 'create-virtualenv', 10:20:46 INFO - 'install', 10:20:46 INFO - 'run-tests'), 10:20:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:20:46 INFO - 'download_minidump_stackwalk': True, 10:20:46 INFO - 'download_symbols': 'ondemand', 10:20:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:20:46 INFO - 'tooltool.py': '/tools/tooltool.py', 10:20:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:20:46 INFO - '/tools/misc-python/virtualenv.py')}, 10:20:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:20:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:20:46 INFO - 'installer_path': 'installer.exe', 10:20:46 INFO - 'log_level': 'info', 10:20:46 INFO - 'log_name': 'talos', 10:20:46 INFO - 'log_to_console': True, 10:20:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:20:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:20:46 INFO - 'opt_config_files': (), 10:20:46 INFO - 'pip_index': False, 10:20:46 INFO - 'sps_profile': False, 10:20:46 INFO - 'sps_profile_interval': 0, 10:20:46 INFO - 'suite': 'dromaeojs', 10:20:46 INFO - 'system_bits': '32', 10:20:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:20:46 INFO - 'title': 'talos-linux64-ix-013', 10:20:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:20:46 INFO - 'use_talos_json': True, 10:20:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:20:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:20:46 INFO - 'work_dir': 'build'} 10:20:46 INFO - [mozharness: 2016-10-18 17:20:46.204594Z] Running clobber step. 10:20:46 INFO - Running pre-action listener: _resource_record_pre_action 10:20:46 INFO - Running main action method: clobber 10:20:46 INFO - rmtree: /builds/slave/test/build 10:20:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:20:47 INFO - Running post-action listener: _resource_record_post_action 10:20:47 INFO - [mozharness: 2016-10-18 17:20:47.192807Z] Finished clobber step (success) 10:20:47 INFO - [mozharness: 2016-10-18 17:20:47.192906Z] Running read-buildbot-config step. 10:20:47 INFO - Running pre-action listener: _resource_record_pre_action 10:20:47 INFO - Running main action method: read_buildbot_config 10:20:47 INFO - Using buildbot properties: 10:20:47 INFO - { 10:20:47 INFO - "project": "", 10:20:47 INFO - "product": "firefox", 10:20:47 INFO - "script_repo_revision": "production", 10:20:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:20:47 INFO - "repository": "", 10:20:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:20:47 INFO - "buildid": "20161018073001", 10:20:47 INFO - "pgo_build": "True", 10:20:47 INFO - "basedir": "/builds/slave/test", 10:20:47 INFO - "buildnumber": 596, 10:20:47 INFO - "slavename": "talos-linux64-ix-013", 10:20:47 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:20:47 INFO - "platform": "ubuntu64_hw", 10:20:47 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:20:47 INFO - "branch": "mozilla-central", 10:20:47 INFO - "repo_path": "mozilla-central", 10:20:47 INFO - "revision": "01ab78dd98805e150b0311cce2351d5b408f3001", 10:20:47 INFO - "stage_platform": "linux64-pgo", 10:20:47 INFO - "builduid": "59288635e980483ba11fedd24e469b6d", 10:20:47 INFO - "slavebuilddir": "test" 10:20:47 INFO - } 10:20:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:20:47 INFO - Running post-action listener: _resource_record_post_action 10:20:47 INFO - [mozharness: 2016-10-18 17:20:47.195325Z] Finished read-buildbot-config step (success) 10:20:47 INFO - [mozharness: 2016-10-18 17:20:47.195412Z] Running download-and-extract step. 10:20:47 INFO - Running pre-action listener: _resource_record_pre_action 10:20:47 INFO - Running main action method: download_and_extract 10:20:47 INFO - mkdir: /builds/slave/test/build/tests 10:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:47 INFO - trying https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:20:47 INFO - Downloading https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/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 10:20:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/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 10:20:47 INFO - Downloaded 1361 bytes. 10:20:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:20:47 INFO - Using the following test package requirements: 10:20:47 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:20:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:20:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:20:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:47 INFO - u'jsshell-linux-x86_64.zip'], 10:20:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:20:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:20:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:20:47 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:20:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:20:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:20:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:20:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:20:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:20:47 INFO - Fetch https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:20:48 INFO - Http code: 200 10:20:48 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 10:20:48 INFO - x-amz-cf-id: 75wdUi-hULSXKjqo-pOCUByvGOHF48P3I0PcmwcuMVJ9scn2zBK9AA== 10:20:48 INFO - x-amz-version-id: GkDlRlaSfq1GwBJLu9buyDaA90NToI_6 10:20:48 INFO - Expected file size: 22090238 10:20:48 INFO - Obtained file size: 22090238 10:20:52 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 10:20:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:20:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:20:52 INFO - Fetch https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:20:53 INFO - Http code: 200 10:20:53 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 10:20:53 INFO - x-amz-cf-id: RxD3glkQRYc6g1pIJUiMioN09rWPw7Wwei20WU4TKY9yOKTQdRx_Vw== 10:20:53 INFO - x-amz-version-id: GkDlRlaSfq1GwBJLu9buyDaA90NToI_6 10:20:53 INFO - Expected file size: 22090238 10:20:53 INFO - Obtained file size: 22090238 10:20:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:20:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:20:58 INFO - Fetch https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:20:58 INFO - Http code: 200 10:20:58 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 10:20:58 INFO - x-amz-cf-id: MQnM3yNJ3RrMAN6mHEuOpLrN8htFAD4EGS_olJOecg3P1NQOilzIrQ== 10:20:58 INFO - x-amz-version-id: 5qX.z6iZHf989DWA7uulr3fl5W6zA6Vi 10:20:58 INFO - Expected file size: 14409028 10:20:58 INFO - Obtained file size: 14409028 10:20: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')]} 10:20:59 INFO - trying https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:20:59 INFO - Downloading https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/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 10:20:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/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 10:21:01 INFO - Downloaded 59484542 bytes. 10:21:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:21:01 INFO - mkdir: /builds/slave/test/properties 10:21:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:21:01 INFO - Writing to file /builds/slave/test/properties/build_url 10:21:01 INFO - Contents: 10:21:01 INFO - build_url:https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:21:02 INFO - Running post-action listener: _resource_record_post_action 10:21:02 INFO - Running post-action listener: set_extra_try_arguments 10:21:02 INFO - [mozharness: 2016-10-18 17:21:02.172456Z] Finished download-and-extract step (success) 10:21:02 INFO - [mozharness: 2016-10-18 17:21:02.172681Z] Running populate-webroot step. 10:21:02 INFO - Running pre-action listener: _resource_record_pre_action 10:21:02 INFO - Running main action method: populate_webroot 10:21:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:21:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:21:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:21:02 INFO - '--tppagecycles', 10:21:02 INFO - '7'], 10:21:02 INFO - 'tests': ['tsvgm']}}, 10:21:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:21:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:21:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:21:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:21:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:21:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:21:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:02 INFO - 'talos_options': ['--disable-e10s'], 10:21:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:21:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:21:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:02 INFO - 'talos_options': ['--disable-e10s'], 10:21:02 INFO - 'tests': ['damp', 'tps']}, 10:21:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:02 INFO - 'tests': ['damp', 'tps']}, 10:21:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:21:02 INFO - 'tests': ['dromaeo_dom']}, 10:21:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:21:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:21:02 INFO - 'tests': ['basic_compositor_video']}, 10:21:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:21:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:21:02 INFO - 'tests': ['a11yr', 10:21:02 INFO - 'ts_paint', 10:21:02 INFO - 'tpaint', 10:21:02 INFO - 'sessionrestore', 10:21:02 INFO - 'sessionrestore_no_auto_restore', 10:21:02 INFO - 'tabpaint']}, 10:21:02 INFO - 'other-e10s': {'tests': ['a11yr', 10:21:02 INFO - 'ts_paint', 10:21:02 INFO - 'tpaint', 10:21:02 INFO - 'sessionrestore', 10:21:02 INFO - 'sessionrestore_no_auto_restore', 10:21:02 INFO - 'tabpaint']}, 10:21:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:21:02 INFO - 'ts_paint', 10:21:02 INFO - 'tpaint', 10:21:02 INFO - 'sessionrestore', 10:21:02 INFO - 'sessionrestore_no_auto_restore', 10:21:02 INFO - 'tabpaint']}, 10:21:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:21:02 INFO - 'ts_paint', 10:21:02 INFO - 'tpaint', 10:21:02 INFO - 'sessionrestore', 10:21:02 INFO - 'sessionrestore_no_auto_restore', 10:21:02 INFO - 'tabpaint']}, 10:21:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:21:02 INFO - 'tests': ['a11yr', 10:21:02 INFO - 'ts_paint', 10:21:02 INFO - 'tpaint', 10:21:02 INFO - 'sessionrestore', 10:21:02 INFO - 'sessionrestore_no_auto_restore', 10:21:02 INFO - 'tabpaint']}, 10:21:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:21:02 INFO - 'tests': ['a11yr', 10:21:02 INFO - 'ts_paint', 10:21:02 INFO - 'tpaint', 10:21:02 INFO - 'sessionrestore', 10:21:02 INFO - 'sessionrestore_no_auto_restore', 10:21:02 INFO - 'tabpaint']}, 10:21:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:21:02 INFO - 'tests': ['tsvgx', 10:21:02 INFO - 'tsvgr_opacity', 10:21:02 INFO - 'tart', 10:21:02 INFO - 'tscrollx', 10:21:02 INFO - 'cart']}, 10:21:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:21:02 INFO - 'tsvgr_opacity', 10:21:02 INFO - 'tart', 10:21:02 INFO - 'tscrollx', 10:21:02 INFO - 'cart']}, 10:21:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:02 INFO - 'talos_options': ['--disable-e10s'], 10:21:02 INFO - 'tests': ['tp5o']}, 10:21:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:02 INFO - 'tests': ['tp5o']}, 10:21:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:02 INFO - 'talos_options': ['--disable-e10s', 10:21:02 INFO - '--xperf_path', 10:21:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:21:02 INFO - 'tests': ['tp5n']}, 10:21:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:02 INFO - 'talos_options': ['--xperf_path', 10:21:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:21:02 INFO - 'tests': ['tp5n']}}, 10:21:02 INFO - 'talos.zip': {'path': '', 10:21:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:21:02 INFO - Running post-action listener: _resource_record_post_action 10:21:02 INFO - [mozharness: 2016-10-18 17:21:02.194261Z] Finished populate-webroot step (success) 10:21:02 INFO - [mozharness: 2016-10-18 17:21:02.194349Z] Running create-virtualenv step. 10:21:02 INFO - Running pre-action listener: _resource_record_pre_action 10:21:02 INFO - Running main action method: create_virtualenv 10:21:02 INFO - Creating virtualenv /builds/slave/test/build/venv 10:21:02 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 10:21:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:21:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:21:02 INFO - Using real prefix '/usr' 10:21:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:21:02 INFO - Installing distribute.............................................................................................................................................................................................done. 10:21:04 INFO - Installing pip.................done. 10:21:04 INFO - Return code: 0 10:21:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:21:04 INFO - Reading from file tmpfile_stdout 10:21:04 INFO - Output received: 10:21:04 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) 10:21:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:21:04 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')]} 10:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:04 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')]} 10:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:04 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 0x7fa8a6d71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2807930>, '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 0x2808830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2808cc0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338', '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 10:21:04 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 10:21:04 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 10:21:04 INFO - Using env: {'DISPLAY': ':0', 10:21:04 INFO - 'HOME': '/home/cltbld', 10:21:04 INFO - 'LANG': 'en_US.UTF-8', 10:21:04 INFO - 'LANGUAGE': 'en_US:en', 10:21:04 INFO - 'LOGNAME': 'cltbld', 10:21:04 INFO - 'MAIL': '/var/mail/cltbld', 10:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:04 INFO - 'MOZ_NO_REMOTE': '1', 10:21:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:04 INFO - 'NO_EM_RESTART': '1', 10:21:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:04 INFO - 'PWD': '/builds/slave/test', 10:21:04 INFO - 'SHELL': '/bin/bash', 10:21:04 INFO - 'SHLVL': '1', 10:21:04 INFO - 'TERM': 'linux', 10:21:04 INFO - 'TMOUT': '86400', 10:21:04 INFO - 'USER': 'cltbld', 10:21:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338', 10:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:04 INFO - '_': '/tools/buildbot/bin/python'} 10:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:05 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 10:21:05 INFO - Cleaning up... 10:21:05 INFO - Return code: 0 10:21:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:05 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 0x7fa8a6d71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2807930>, '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 0x2808830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2808cc0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338', '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 10:21:05 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 10:21:05 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 10:21:05 INFO - Using env: {'DISPLAY': ':0', 10:21:05 INFO - 'HOME': '/home/cltbld', 10:21:05 INFO - 'LANG': 'en_US.UTF-8', 10:21:05 INFO - 'LANGUAGE': 'en_US:en', 10:21:05 INFO - 'LOGNAME': 'cltbld', 10:21:05 INFO - 'MAIL': '/var/mail/cltbld', 10:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:05 INFO - 'MOZ_NO_REMOTE': '1', 10:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:05 INFO - 'NO_EM_RESTART': '1', 10:21:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:05 INFO - 'PWD': '/builds/slave/test', 10:21:05 INFO - 'SHELL': '/bin/bash', 10:21:05 INFO - 'SHLVL': '1', 10:21:05 INFO - 'TERM': 'linux', 10:21:05 INFO - 'TMOUT': '86400', 10:21:05 INFO - 'USER': 'cltbld', 10:21:05 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338', 10:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:05 INFO - '_': '/tools/buildbot/bin/python'} 10:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:05 INFO - Downloading/unpacking psutil>=3.1.1 10:21:05 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 10:21:05 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 10:21:05 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 10:21:05 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 10:21:05 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 10:21:05 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 10:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:21:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:21:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:21:07 INFO - Installing collected packages: psutil 10:21:07 INFO - Running setup.py install for psutil 10:21:07 INFO - building 'psutil._psutil_linux' extension 10:21:07 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 10:21:07 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 10:21:07 INFO - building 'psutil._psutil_posix' extension 10:21:07 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 10:21:07 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 10:21:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:21:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:21:07 INFO - Successfully installed psutil 10:21:07 INFO - Cleaning up... 10:21:08 INFO - Return code: 0 10:21:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:21: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')]} 10:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21: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')]} 10:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:08 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 0x7fa8a6d71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2807930>, '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 0x2808830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2808cc0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338', '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 10:21:08 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 10:21:08 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 10:21:08 INFO - Using env: {'DISPLAY': ':0', 10:21:08 INFO - 'HOME': '/home/cltbld', 10:21:08 INFO - 'LANG': 'en_US.UTF-8', 10:21:08 INFO - 'LANGUAGE': 'en_US:en', 10:21:08 INFO - 'LOGNAME': 'cltbld', 10:21:08 INFO - 'MAIL': '/var/mail/cltbld', 10:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:08 INFO - 'MOZ_NO_REMOTE': '1', 10:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:08 INFO - 'NO_EM_RESTART': '1', 10:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:08 INFO - 'PWD': '/builds/slave/test', 10:21:08 INFO - 'SHELL': '/bin/bash', 10:21:08 INFO - 'SHLVL': '1', 10:21:08 INFO - 'TERM': 'linux', 10:21:08 INFO - 'TMOUT': '86400', 10:21:08 INFO - 'USER': 'cltbld', 10:21:08 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338', 10:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:08 INFO - '_': '/tools/buildbot/bin/python'} 10:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:21:08 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 10:21:08 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 10:21:08 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 10:21:08 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 10:21:08 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 10:21:08 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 10:21:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:21:10 INFO - Installing collected packages: mozsystemmonitor 10:21:10 INFO - Running setup.py install for mozsystemmonitor 10:21:10 INFO - Successfully installed mozsystemmonitor 10:21:10 INFO - Cleaning up... 10:21:10 INFO - Return code: 0 10:21:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:21:10 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')]} 10:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:10 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')]} 10:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:10 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 0x7fa8a6d71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2807930>, '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 0x2808830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2808cc0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338', '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 10:21:10 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 10:21:10 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 10:21:10 INFO - Using env: {'DISPLAY': ':0', 10:21:10 INFO - 'HOME': '/home/cltbld', 10:21:10 INFO - 'LANG': 'en_US.UTF-8', 10:21:10 INFO - 'LANGUAGE': 'en_US:en', 10:21:10 INFO - 'LOGNAME': 'cltbld', 10:21:10 INFO - 'MAIL': '/var/mail/cltbld', 10:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:10 INFO - 'MOZ_NO_REMOTE': '1', 10:21:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:10 INFO - 'NO_EM_RESTART': '1', 10:21:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:10 INFO - 'PWD': '/builds/slave/test', 10:21:10 INFO - 'SHELL': '/bin/bash', 10:21:10 INFO - 'SHLVL': '1', 10:21:10 INFO - 'TERM': 'linux', 10:21:10 INFO - 'TMOUT': '86400', 10:21:10 INFO - 'USER': 'cltbld', 10:21:10 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338', 10:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:10 INFO - '_': '/tools/buildbot/bin/python'} 10:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:10 INFO - Downloading/unpacking jsonschema==2.5.1 10:21:10 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 10:21:10 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 10:21:10 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 10:21:10 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 10:21:10 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 10:21:10 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 10:21:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:21:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21:12 INFO - Downloading functools32-3.2.3-2.tar.gz 10:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:21:12 INFO - warning: no files found matching '*.txt' 10:21:12 INFO - no previously-included directories found matching 'build' 10:21:12 INFO - no previously-included directories found matching 'dist' 10:21:12 INFO - no previously-included directories found matching '.git*' 10:21:12 INFO - Installing collected packages: jsonschema, functools32 10:21:12 INFO - Running setup.py install for functools32 10:21:12 INFO - warning: no files found matching '*.txt' 10:21:12 INFO - no previously-included directories found matching 'build' 10:21:12 INFO - no previously-included directories found matching 'dist' 10:21:12 INFO - no previously-included directories found matching '.git*' 10:21:12 INFO - Successfully installed jsonschema functools32 10:21:12 INFO - Cleaning up... 10:21:12 INFO - Return code: 0 10:21:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:21: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')]} 10:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21: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')]} 10:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21: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', '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 0x7fa8a6d71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2807930>, '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 0x2808830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2808cc0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338', '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 10:21: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:21: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 functools32==3.2.3-2 10:21:12 INFO - Using env: {'DISPLAY': ':0', 10:21:12 INFO - 'HOME': '/home/cltbld', 10:21:12 INFO - 'LANG': 'en_US.UTF-8', 10:21:12 INFO - 'LANGUAGE': 'en_US:en', 10:21:12 INFO - 'LOGNAME': 'cltbld', 10:21:12 INFO - 'MAIL': '/var/mail/cltbld', 10:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:12 INFO - 'MOZ_NO_REMOTE': '1', 10:21:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:12 INFO - 'NO_EM_RESTART': '1', 10:21:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:12 INFO - 'PWD': '/builds/slave/test', 10:21:12 INFO - 'SHELL': '/bin/bash', 10:21:12 INFO - 'SHLVL': '1', 10:21:12 INFO - 'TERM': 'linux', 10:21:12 INFO - 'TMOUT': '86400', 10:21:12 INFO - 'USER': 'cltbld', 10:21:12 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338', 10:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:12 INFO - '_': '/tools/buildbot/bin/python'} 10:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:21:13 INFO - Cleaning up... 10:21:13 INFO - Return code: 0 10:21:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:21:13 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')]} 10:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:13 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')]} 10:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:13 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 0x7fa8a6d71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2807930>, '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 0x2808830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2808cc0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338', '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 10:21:13 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 10:21:13 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 10:21:13 INFO - Using env: {'DISPLAY': ':0', 10:21:13 INFO - 'HOME': '/home/cltbld', 10:21:13 INFO - 'LANG': 'en_US.UTF-8', 10:21:13 INFO - 'LANGUAGE': 'en_US:en', 10:21:13 INFO - 'LOGNAME': 'cltbld', 10:21:13 INFO - 'MAIL': '/var/mail/cltbld', 10:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:13 INFO - 'MOZ_NO_REMOTE': '1', 10:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:13 INFO - 'NO_EM_RESTART': '1', 10:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:13 INFO - 'PWD': '/builds/slave/test', 10:21:13 INFO - 'SHELL': '/bin/bash', 10:21:13 INFO - 'SHLVL': '1', 10:21:13 INFO - 'TERM': 'linux', 10:21:13 INFO - 'TMOUT': '86400', 10:21:13 INFO - 'USER': 'cltbld', 10:21:13 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338', 10:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:13 INFO - '_': '/tools/buildbot/bin/python'} 10:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:13 INFO - Downloading/unpacking blobuploader==1.2.4 10:21:13 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 10:21:13 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 10:21:13 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 10:21:13 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 10:21:13 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 10:21:13 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 10:21:15 INFO - Downloading blobuploader-1.2.4.tar.gz 10:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:21:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:21:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21:16 INFO - Downloading docopt-0.6.1.tar.gz 10:21:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:21:16 INFO - Installing collected packages: blobuploader, requests, docopt 10:21:16 INFO - Running setup.py install for blobuploader 10:21:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:21:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:21:16 INFO - Running setup.py install for requests 10:21:16 INFO - Running setup.py install for docopt 10:21:16 INFO - Successfully installed blobuploader requests docopt 10:21:16 INFO - Cleaning up... 10:21:16 INFO - Return code: 0 10:21:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:16 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')]} 10:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:16 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')]} 10:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:16 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 0x7fa8a6d71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2807930>, '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 0x2808830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2808cc0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338', '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 10:21:16 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 10:21:16 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 10:21:16 INFO - Using env: {'DISPLAY': ':0', 10:21:16 INFO - 'HOME': '/home/cltbld', 10:21:16 INFO - 'LANG': 'en_US.UTF-8', 10:21:16 INFO - 'LANGUAGE': 'en_US:en', 10:21:16 INFO - 'LOGNAME': 'cltbld', 10:21:16 INFO - 'MAIL': '/var/mail/cltbld', 10:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:16 INFO - 'MOZ_NO_REMOTE': '1', 10:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:16 INFO - 'NO_EM_RESTART': '1', 10:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:16 INFO - 'PWD': '/builds/slave/test', 10:21:16 INFO - 'SHELL': '/bin/bash', 10:21:16 INFO - 'SHLVL': '1', 10:21:16 INFO - 'TERM': 'linux', 10:21:16 INFO - 'TMOUT': '86400', 10:21:16 INFO - 'USER': 'cltbld', 10:21:16 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338', 10:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:16 INFO - '_': '/tools/buildbot/bin/python'} 10:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:21:16 INFO - Running setup.py (path:/tmp/pip-JlHTaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:21:17 INFO - Running setup.py (path:/tmp/pip-tINkab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:21:17 INFO - Running setup.py (path:/tmp/pip-SWsqVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:21:17 INFO - Running setup.py (path:/tmp/pip-M4H0HG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:21:17 INFO - Running setup.py (path:/tmp/pip-3mXjm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:21:17 INFO - Running setup.py (path:/tmp/pip-x4obvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:21:17 INFO - Running setup.py (path:/tmp/pip-lcxPcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:21:17 INFO - Running setup.py (path:/tmp/pip-jx65L7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:21:17 INFO - Running setup.py (path:/tmp/pip-WXvoRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:21:17 INFO - Running setup.py (path:/tmp/pip-SCe8ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:21:17 INFO - Running setup.py (path:/tmp/pip-HeqmNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:21:17 INFO - Running setup.py (path:/tmp/pip-cqQAEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:21:17 INFO - Running setup.py (path:/tmp/pip-HL48Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:21:17 INFO - Running setup.py (path:/tmp/pip-RFqoXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:17 INFO - Running setup.py (path:/tmp/pip-_qFboX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:21:18 INFO - Running setup.py (path:/tmp/pip-M5J7aA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:21:18 INFO - Running setup.py (path:/tmp/pip-oB9Brd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:21:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:21:18 INFO - Running setup.py install for manifestparser 10:21:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:21:18 INFO - Running setup.py install for mozcrash 10:21:18 INFO - Running setup.py install for mozdebug 10:21:18 INFO - Running setup.py install for mozdevice 10:21:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:21:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:21:18 INFO - Running setup.py install for mozfile 10:21:18 INFO - Running setup.py install for mozhttpd 10:21:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:21:18 INFO - Running setup.py install for mozinfo 10:21:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:21:18 INFO - Running setup.py install for mozInstall 10:21:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:21:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:21:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:21:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:21:18 INFO - Running setup.py install for mozleak 10:21:19 INFO - Running setup.py install for mozlog 10:21:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:21:19 INFO - Running setup.py install for moznetwork 10:21:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:21:19 INFO - Running setup.py install for mozprocess 10:21:19 INFO - Running setup.py install for mozprofile 10:21:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:21:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:21:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:21:19 INFO - Running setup.py install for mozrunner 10:21:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:21:19 INFO - Running setup.py install for mozscreenshot 10:21:19 INFO - Running setup.py install for moztest 10:21:19 INFO - Running setup.py install for mozversion 10:21:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:21:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:21:19 INFO - Cleaning up... 10:21:19 INFO - Return code: 0 10:21:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:19 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')]} 10:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:19 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')]} 10:21:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:19 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 0x7fa8a6d71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2807930>, '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 0x2808830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2808cc0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338', '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 10:21:19 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 10:21:19 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 10:21:19 INFO - Using env: {'DISPLAY': ':0', 10:21:19 INFO - 'HOME': '/home/cltbld', 10:21:19 INFO - 'LANG': 'en_US.UTF-8', 10:21:19 INFO - 'LANGUAGE': 'en_US:en', 10:21:19 INFO - 'LOGNAME': 'cltbld', 10:21:19 INFO - 'MAIL': '/var/mail/cltbld', 10:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:19 INFO - 'MOZ_NO_REMOTE': '1', 10:21:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:19 INFO - 'NO_EM_RESTART': '1', 10:21:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:19 INFO - 'PWD': '/builds/slave/test', 10:21:19 INFO - 'SHELL': '/bin/bash', 10:21:19 INFO - 'SHLVL': '1', 10:21:19 INFO - 'TERM': 'linux', 10:21:19 INFO - 'TMOUT': '86400', 10:21:19 INFO - 'USER': 'cltbld', 10:21:19 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338', 10:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:19 INFO - '_': '/tools/buildbot/bin/python'} 10:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:21:20 INFO - Running setup.py (path:/tmp/pip-yqCal7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:21:20 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)) 10:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:21:20 INFO - Running setup.py (path:/tmp/pip-IhYZYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:21:20 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)) 10:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:21:20 INFO - Running setup.py (path:/tmp/pip-pRXYJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:21:20 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)) 10:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:21:20 INFO - Running setup.py (path:/tmp/pip-wNJ7i_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:21:20 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)) 10:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:21:20 INFO - Running setup.py (path:/tmp/pip-mlE8J9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:21:20 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)) 10:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:21:20 INFO - Running setup.py (path:/tmp/pip-7AZhSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:21:20 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)) 10:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:21:20 INFO - Running setup.py (path:/tmp/pip-G5xdTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:21:20 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)) 10:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:21:20 INFO - Running setup.py (path:/tmp/pip-9S_0yL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:21:20 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)) 10:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:21:20 INFO - Running setup.py (path:/tmp/pip-A0DoX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:21:20 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)) 10:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:21:20 INFO - Running setup.py (path:/tmp/pip-zIOOfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:21:20 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)) 10:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:21:20 INFO - Running setup.py (path:/tmp/pip-WrdrRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:21:20 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)) 10:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:21:20 INFO - Running setup.py (path:/tmp/pip-Jor4SX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:21:21 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)) 10:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:21:21 INFO - Running setup.py (path:/tmp/pip-BBkT_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:21:21 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)) 10:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:21:21 INFO - Running setup.py (path:/tmp/pip-IlGG6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:21:21 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)) 10:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:21 INFO - Running setup.py (path:/tmp/pip-DG7CGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:21 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)) 10:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:21:21 INFO - Running setup.py (path:/tmp/pip-qQPsJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:21:21 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)) 10:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:21:21 INFO - Running setup.py (path:/tmp/pip-f4XX5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:21:21 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)) 10:21:21 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)) 10:21:21 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)) 10:21:21 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)) 10:21:21 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)) 10:21:21 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)) 10:21:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:21:21 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 10:21:21 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 10:21:21 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 10:21:21 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 10:21:21 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 10:21:21 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 10:21:23 INFO - Downloading blessings-1.6.tar.gz 10:21:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:21:23 INFO - Installing collected packages: blessings 10:21:23 INFO - Running setup.py install for blessings 10:21:23 INFO - Successfully installed blessings 10:21:23 INFO - Cleaning up... 10:21:23 INFO - Return code: 0 10:21:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:21:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:21:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:21:23 INFO - Reading from file tmpfile_stdout 10:21:23 INFO - Current package versions: 10:21:23 INFO - argparse == 1.2.1 10:21:23 INFO - blessings == 1.6 10:21:23 INFO - blobuploader == 1.2.4 10:21:23 INFO - docopt == 0.6.1 10:21:23 INFO - functools32 == 3.2.3-2 10:21:23 INFO - jsonschema == 2.5.1 10:21:23 INFO - manifestparser == 1.1 10:21:23 INFO - mozInstall == 1.12 10:21:23 INFO - mozcrash == 0.17 10:21:23 INFO - mozdebug == 0.1 10:21:23 INFO - mozdevice == 0.48 10:21:23 INFO - mozfile == 1.2 10:21:23 INFO - mozhttpd == 0.7 10:21:23 INFO - mozinfo == 0.9 10:21:23 INFO - mozleak == 0.1 10:21:23 INFO - mozlog == 3.4 10:21:23 INFO - moznetwork == 0.27 10:21:23 INFO - mozprocess == 0.23 10:21:23 INFO - mozprofile == 0.28 10:21:23 INFO - mozrunner == 6.12 10:21:23 INFO - mozscreenshot == 0.1 10:21:23 INFO - mozsystemmonitor == 0.3 10:21:23 INFO - moztest == 0.7 10:21:23 INFO - mozversion == 1.4 10:21:23 INFO - psutil == 3.1.1 10:21:23 INFO - requests == 1.2.3 10:21:23 INFO - wsgiref == 0.1.2 10:21:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:23 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')]} 10:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:23 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')]} 10:21:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:23 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 0x7fa8a6d71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2807930>, '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 0x2808830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2808cc0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338', '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 10:21:23 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 10:21:23 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 10:21:23 INFO - Using env: {'DISPLAY': ':0', 10:21:23 INFO - 'HOME': '/home/cltbld', 10:21:23 INFO - 'LANG': 'en_US.UTF-8', 10:21:23 INFO - 'LANGUAGE': 'en_US:en', 10:21:23 INFO - 'LOGNAME': 'cltbld', 10:21:23 INFO - 'MAIL': '/var/mail/cltbld', 10:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:23 INFO - 'MOZ_NO_REMOTE': '1', 10:21:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:23 INFO - 'NO_EM_RESTART': '1', 10:21:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:23 INFO - 'PWD': '/builds/slave/test', 10:21:23 INFO - 'SHELL': '/bin/bash', 10:21:23 INFO - 'SHLVL': '1', 10:21:23 INFO - 'TERM': 'linux', 10:21:23 INFO - 'TMOUT': '86400', 10:21:23 INFO - 'USER': 'cltbld', 10:21:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338', 10:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:23 INFO - '_': '/tools/buildbot/bin/python'} 10:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:24 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)) 10:21:24 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)) 10:21:24 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)) 10:21:24 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)) 10:21:24 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)) 10:21:24 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)) 10:21:24 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)) 10:21:24 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)) 10:21:24 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)) 10:21:24 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)) 10:21:24 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)) 10:21:24 INFO - Cleaning up... 10:21:24 INFO - Return code: 0 10:21:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:21: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')]} 10:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21: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')]} 10:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8a6d71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2807930>, '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 0x2808830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2808cc0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338', '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 10:21:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:21:24 INFO - Using env: {'DISPLAY': ':0', 10:21:24 INFO - 'HOME': '/home/cltbld', 10:21:24 INFO - 'LANG': 'en_US.UTF-8', 10:21:24 INFO - 'LANGUAGE': 'en_US:en', 10:21:24 INFO - 'LOGNAME': 'cltbld', 10:21:24 INFO - 'MAIL': '/var/mail/cltbld', 10:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:24 INFO - 'MOZ_NO_REMOTE': '1', 10:21:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:24 INFO - 'NO_EM_RESTART': '1', 10:21:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:24 INFO - 'PWD': '/builds/slave/test', 10:21:24 INFO - 'SHELL': '/bin/bash', 10:21:24 INFO - 'SHLVL': '1', 10:21:24 INFO - 'TERM': 'linux', 10:21:24 INFO - 'TMOUT': '86400', 10:21:24 INFO - 'USER': 'cltbld', 10:21:24 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338', 10:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:24 INFO - '_': '/tools/buildbot/bin/python'} 10:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:21:24 INFO - Cleaning up... 10:21:24 INFO - Return code: 0 10:21:24 INFO - Running post-action listener: _resource_record_post_action 10:21:24 INFO - Running post-action listener: _start_resource_monitoring 10:21:24 INFO - Starting resource monitoring. 10:21:24 INFO - [mozharness: 2016-10-18 17:21:24.287194Z] Finished create-virtualenv step (success) 10:21:24 INFO - [mozharness: 2016-10-18 17:21:24.287658Z] Running install step. 10:21:24 INFO - Running pre-action listener: _resource_record_pre_action 10:21:24 INFO - Running main action method: install 10:21:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:21:24 INFO - Reading from file tmpfile_stdout 10:21:24 INFO - Detecting whether we're running mozinstall >=1.0... 10:21:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:21:24 INFO - Reading from file tmpfile_stdout 10:21:24 INFO - Output received: 10:21:24 INFO - Usage: mozinstall [options] installer 10:21:24 INFO - Options: 10:21:24 INFO - -h, --help show this help message and exit 10:21:24 INFO - -d DEST, --destination=DEST 10:21:24 INFO - Directory to install application into. [default: 10:21:24 INFO - "/builds/slave/test"] 10:21:24 INFO - --app=APP Application being installed. [default: firefox] 10:21:24 INFO - mkdir: /builds/slave/test/build/application 10:21:24 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'] 10:21:24 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 10:21:41 INFO - Reading from file tmpfile_stdout 10:21:41 INFO - Output received: 10:21:41 INFO - /builds/slave/test/build/application/firefox/firefox 10:21:41 INFO - Running post-action listener: _resource_record_post_action 10:21:41 INFO - [mozharness: 2016-10-18 17:21:41.527366Z] Finished install step (success) 10:21:41 INFO - [mozharness: 2016-10-18 17:21:41.527610Z] Running run-tests step. 10:21:41 INFO - Running pre-action listener: _resource_record_pre_action 10:21:41 INFO - Running main action method: run_tests 10:21:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:21:41 INFO - Python 2.7.3 10:21:41 INFO - Return code: 0 10:21:41 INFO - grabbing minidump binary from tooltool 10:21:41 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')]} 10:21:41 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 0x2807930>, '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 0x2808830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2808cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:21:41 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 10:21:41 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 10:21:41 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 10:21:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:21:41 INFO - Return code: 0 10:21:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:21:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:21:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:21:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:21:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:21:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 10:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 10:21:41 INFO - Using env: {'DISPLAY': ':0', 10:21:41 INFO - 'HOME': '/home/cltbld', 10:21:41 INFO - 'LANG': 'en_US.UTF-8', 10:21:41 INFO - 'LANGUAGE': 'en_US:en', 10:21:41 INFO - 'LOGNAME': 'cltbld', 10:21:41 INFO - 'MAIL': '/var/mail/cltbld', 10:21:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:21:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:41 INFO - 'MOZ_NO_REMOTE': '1', 10:21:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:21:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:41 INFO - 'NO_EM_RESTART': '1', 10:21:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:41 INFO - 'PWD': '/builds/slave/test', 10:21:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:21:41 INFO - 'SHELL': '/bin/bash', 10:21:41 INFO - 'SHLVL': '1', 10:21:41 INFO - 'TERM': 'linux', 10:21:41 INFO - 'TMOUT': '86400', 10:21:41 INFO - 'USER': 'cltbld', 10:21:41 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338', 10:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:41 INFO - '_': '/tools/buildbot/bin/python'} 10:21:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 10:21:41 INFO - mozversion application_buildid: 20161018073001 10:21:41 INFO - mozversion application_changeset: 01ab78dd98805e150b0311cce2351d5b408f3001 10:21:41 INFO - mozversion application_display_name: Nightly 10:21:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:21:41 INFO - mozversion application_name: Firefox 10:21:41 INFO - mozversion application_remotingname: firefox 10:21:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:21:41 INFO - mozversion application_vendor: Mozilla 10:21:41 INFO - mozversion application_version: 52.0a1 10:21:41 INFO - mozversion platform_buildid: 20161018073001 10:21:41 INFO - mozversion platform_changeset: 01ab78dd98805e150b0311cce2351d5b408f3001 10:21:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:21:41 INFO - mozversion platform_version: 52.0a1 10:21:41 INFO - using testdate: 1476811301 10:21:41 INFO - actual date: 1476811301 10:21:41 INFO - starting webserver on 'localhost:33232' 10:21:41 INFO - SUITE-START | Running 2 tests 10:21:41 INFO - TEST-START | dromaeo_css 10:21:41 INFO - operating with platform_type : linux_ 10:21:41 INFO - Initialising browser for dromaeo_css test... 10:21:41 INFO - TEST-INFO | started process 29497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgKtLKQ/profile http://localhost:33232/getInfo.html) 10:21:46 INFO - PROCESS | 29497 | __metrics Screen width/height:1600/1200 10:21:46 INFO - PROCESS | 29497 | colorDepth:24 10:21:46 INFO - PROCESS | 29497 | Browser inner width/height: 1024/697 10:21:46 INFO - PROCESS | 29497 | __metrics 10:21:46 INFO - PROCESS | 29497 | 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" 10:21:46 INFO - PROCESS | 29497 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:21:47 INFO - PROCESS | 29497 | console.error: PushService: 10:21:47 INFO - PROCESS | 29497 | stateChangeProcessEnqueue: Error transitioning state 10:21:47 INFO - PROCESS | 29497 | UnknownError 10:21:48 INFO - TEST-INFO | 29497: exit 0 10:21:48 INFO - Browser initialized. 10:21:48 INFO - Running cycle 1/1 for dromaeo_css test... 10:21:48 INFO - TEST-INFO | started process 29577 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgKtLKQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:22:00 INFO - PROCESS | 29577 | RSS: Main: 171986944 10:22:00 INFO - PROCESS | 29577 | 10:22:50 INFO - PROCESS | 29577 | 1476811370953 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] 10:25:02 INFO - PROCESS | 29577 | Cycle 1(1): loaded http://localhost:33232/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33232/tests/dromaeo/cssquery-ext.html) 10:25:03 INFO - PROCESS | 29577 | RSS: Main: 283283456 10:25:03 INFO - PROCESS | 29577 | 10:28:06 INFO - PROCESS | 29577 | Cycle 1(1): loaded http://localhost:33232/tests/dromaeo/cssquery-ext.html (next: http://localhost:33232/tests/dromaeo/cssquery-jquery.html) 10:28:07 INFO - PROCESS | 29577 | RSS: Main: 280797184 10:28:07 INFO - PROCESS | 29577 | 10:31:09 INFO - PROCESS | 29577 | Cycle 1(1): loaded http://localhost:33232/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33232/tests/dromaeo/cssquery-mootools.html) 10:31:09 INFO - PROCESS | 29577 | RSS: Main: 260288512 10:31:09 INFO - PROCESS | 29577 | 10:34:11 INFO - PROCESS | 29577 | Cycle 1(1): loaded http://localhost:33232/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33232/tests/dromaeo/cssquery-prototype.html) 10:34:12 INFO - PROCESS | 29577 | RSS: Main: 220680192 10:34:12 INFO - PROCESS | 29577 | 10:37:15 INFO - PROCESS | 29577 | Cycle 1(1): loaded http://localhost:33232/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33232/tests/dromaeo/cssquery-yui.html) 10:37:15 INFO - PROCESS | 29577 | RSS: Main: 222470144 10:37:15 INFO - PROCESS | 29577 | 10:40:18 INFO - PROCESS | 29577 | Cycle 1(1): loaded http://localhost:33232/tests/dromaeo/cssquery-yui.html (next: http://localhost:33232/tests/dromaeo/cssquery-dojo.html) 10:40:18 INFO - PROCESS | 29577 | RSS: Main: 313683968 10:40:18 INFO - PROCESS | 29577 | 10:40:18 INFO - PROCESS | 29577 | __start_tp_report 10:40:18 INFO - PROCESS | 29577 | _x_x_mozilla_page_load 10:40:18 INFO - PROCESS | 29577 | _x_x_mozilla_page_load_details 10:40:18 INFO - PROCESS | 29577 | |i|pagename|runs| 10:40:18 INFO - PROCESS | 29577 | |0;dojo.html;2971.717686819752;2978.4787662159124;2986.656534498532;3008.3682426690393;3035.2563621912623;5017.071841709278;5087.313212716283;5100.872478188047;5147.073526765181;5176.767045482958;5122.103631864427;5134.229865520165;5147.948520514794;5148.742562871851;5152.768125434355;4656.930146047804;4678.97660511697;4688.2733176357715;4729.172394830908;4736.52634736527;4754.6434017448655;4766.261229509431;4797.9520204797855;4799.904001919959;4801.495842936493;4718.079974404993;4744.928826067612;4768.260919557474;4784.856454306377;4786.856394308176;4750.501197374295;4762.071396077767;4765.594924431445;4778.4265888093305;4843.24929635907;4581.3815134956685;4619.838305659319;4643.419572553431;4700.976495117537;4760.952390476085;5106.157484015133;5107.821226257063;5116;5124.256982737519;5142.228665700138;5440.020796256672;5460.426655201187;5474.507294343528;5481.643693159932;5503.587230957694;5282.075636763551;5334.333208348957;5469.589780766419;5511.366192887829;5512.751926163332;5165.612579056548;5178.766955487012;5181.326427564468;5234.398044224925;5247;5626.606137570413;5635.464630860061;5643.379228284885;5646.124850648156;5646.491815736521;5292.576593872481;5357.491038351351;5407.756650950717;5410.891782164414;5476.808311709071;5406.053940560386;5425.104857698515;5457.399686034533;5495.368032676293;5531.004419204502;5359.249705041298;5407.297051383373;5412.296401467784;5414.187871819258;5422.186671999153;5336.573074154058;5366.195070739421;5419.078756611386;5419.701916394557;5474.069408200616;4235;4269;4269.252880745919;4269.637080848162;4278.55075217104;3820.2932457495453;3827.1962887793875;3839.2897313997;3845.4616353710503;3858.324793161242;5213.40045894727;5220.3735551734035;5224.216367544823;5227.738613069331;5227.973860130675;5390.649607775482;5431.53831924283;5438.15708565173;5482.533984611273;5493.807716729975;5150.845474635767;5222.503862133091;5229.633925625246;5238.345206849144;5239.345081864767;4738.19450693383;4756.072565849695;4757.333973243749;4761.857144285677;4812.013537224861;5507.917381239205;5574.1081426972305;5577.776888924479;5579.8884022320135;5580.609357344947;5428.104362780097;5462.9180562292395;5485.533729633026;5586.553075754011;5601.60788744784;5677.801276955287;5684.033714268501;5684.488396044376;5696.715164241854;5746.569007324384;5471.72641367938;5479.178123281539;5481.342238931354;5482.095454250004;5486.945130548644;5371.194320851903;5415.756290966995;5452.045891968969;5457.290552228185;5551.365364155305;5432.701201433959;5436.6194366393975;5438.15708565173;5475.863103422446;5493.285872836505;5400.05499037659;5402.486763757437;5403.378611459575;5408.675479471244;5468.398476167539;5246.396664383492;5286.312779338661;5296.867578310573;5333.679979201261;5339.973300133474;5447;5485.067538518381;5485.286912701324;5539.030669632718;5556.249906262765;5332.146856502941;5362.410134885237;5374.220737993047;5376.973115134399;5446.891062178655 10:40:18 INFO - PROCESS | 29577 | |1;ext.html;590.6249531547468;626.114048621201;630.2972186012596;645.7610684046904;647.6988200486772;31956;41026.17947641049;42401.57598424019;42449.15101697964;46165;44220;44422.33366499497;44610.77694611523;44818.77590612051;44878;8726.389152759293;8887.244584210317;8891.777705557348;8894.555272236395;8897.021327653953;8718;8808.383413161082;8808.471491710518;8808.735737927873;8810.911890881105;8861;8909.1536304051;8913.955430222872;8918.375713700012;8921.10788921106;8780.385373023892;8836.46981181128;8852.247558957497;8877.245434138105;8885.4668719877;8674.956625216833;8687.652493900236;8764.56177191138;8766.254868336198;8771;41578.79210603928;41969.580304196876;42044.369334459705;42050;42076.57923420757;3042.4675681755825;3298.4062868683627;3474.1488335358;3551.662592053751;3649.069487280753;32182.678173218203;32188;32452;33959.660403395894;34011.659883401095;3856.730028897978;3880.262750077476;3902.512185976753;4050.331695270306;4121.278776214151;316986;317398.4130079358;319897;320788;320915;56990;57278;57332;57364.426355736745;57458;33913.660863391546;35081.47377789335;35206.29587408289;59468.70265648644;59603.403965959784;13200.801987969997;13332.800007999887;13337.133086349357;13342.93328533351;13349.399277032557;11559.190856640123;11593.6521904343;11594.246373985665;11638.476268567934;11639.243449175776;18952.715709264372;18988.525286867938;19043.333483328017;19145.617087658167;19148.712769308473;6950.339717726808;7102.325279098477;7121.35907768293;7155.391791697764;7203.38771204443;781.5896654256561;905.3345790843724;919.8160367926441;939.0187254319253;999.195647503752;30332.23687499368;31118.377632447224;31127.221819454695;31669.52495712566;32004;870.6734974384606;907.7140700679265;955.4028732042474;964.1322809471532;1039.0752230514847;15522;16485.34058637665;16529.83470165307;16586.419475318307;16836.32654693823;470998;471555;473588;473978;476009;56721.43278567244;56803.43196568064;56867;56884.71557642268;57155.42844571584;1180.4628893853276;1217.117589747426;1223.1926928227506;1285.5436320106414;1322.9536966206138;28771.85614072;30786.38427231398;32155.51766723548;33495.49756753602;34144.317113658086;52682.473175267754;53429.46570534245;53574.73212634068;53583.99999999844;53585;400044;401907;402230;403346;405925;24707.62938555959;24969.87515062413;25072.49855002926;25178.24465266045;25186.37034074163;45532.77233613811;46553.3017004752;46578.301325480825;46870;47133;37655.81172094122;38699;38920.41619375655;39726.20547588974;39814;38376;38654;39174.41238381484;39983.2003359937;40138;33122.0316952459;34034.489482657285;34493.13767155841;34891.30217395587;35466.11334716653;33502;35916;36486.817565912;36699.08252293607;36821;26447.73552264453;27054;27332.863335683196;27520;27748.72251277542 10:40:18 INFO - PROCESS | 29577 | |2;jquery.html;369.21725941005064;371.97954112523803;376.5443812986287;382.13446543578783;394.29027750049903;16801.747973780402;18117.184726687297;18178.272869085253;18210.726839097406;18268;15756.763648545253;16138.625243028997;16589.585260368465;16655.750163747554;16689.83310166898;5441.755121019553;5713.514351280146;5715.914261286063;5717.571182161355;5717.942820571782;4050.7772072536;4065.5527891931865;5595.776168953257;6291.307956124822;6322.020086886517;6209.975354066573;6334.334894836045;6345.238571371442;6347.746090156388;6350;6191.257049154108;6267.4986001119805;6296.1500197473215;6311.684415779193;6321.715522801462;5456.945430545684;5513.669179849222;5515.310586176728;5564.026295398329;5569.415211402785;22578;22631.77368226313;22653.886730566406;22732.204372847038;22849;2355.4229213842546;2442.4504486490573;2571.819972601919;2679.6516452861197;2834.6456692913384;10024.198064154923;10502.474876256232;10604.893951060469;10704.036636702735;13834.584962451143;1884.67960446723;1907.895065771382;1934.5743936333984;1936.1964784614368;2061.9278325258542;77225;82253;84255.57872210661;84869.15130848675;85910.14089859083;10663.4135122569;10704;11047;11109.44452777358;11207.71980700489;15402;15423.691526169414;15448.613784655248;15451.536453906401;15457.304421301069;7438.218987006287;7677.539347639159;7699.961500192463;7852;7935.920640793518;7152.17749958751;7356.521826081287;7446.851062978819;7549.0941087069905;7622.199669034782;4494.393256910341;4635.119327327797;4695.154872122982;4733.337332773414;4764.213904705754;1808.2043900683657;1817.151585326807;1829.8288945984837;1939.322486049557;1996.9600607987759;922.3359181389388;945.8770359853175;947.5688561704408;971.1987610221596;981.2248323824242;17896.194671239824;18378.356757513422;18524.98112603793;19299.51751206231;19681.819090854595;908.8273228086774;944.7213072143734;947.8436058050345;984.0405604535521;986.5067466266867;10225.795484090277;10413.5834566618;10712.678619641423;10721.35671859691;10734.087602553715;416459;428305;431704;431980;433177;55229.17156242659;66166.66916665385;84744.57627711822;86978;88180;936.4100616611491;959.4339339789418;987.6888780034266;992.0426788149471;992.9056739609725;15661.686766264384;16134.112623805804;16341.346346146021;17023;17353.566160845574;37438.62561374351;39461.22424490847;40577.391339130525;40650.796746017266;41755.7912210437;54628.45371546234;55447.44552554423;56851.14723279237;57182.42817571771;57569.12154392347;8024.638891250024;8116.431849770459;8177.754667359989;8416.747497575083;8464.587592536098;9286.07139286066;12242.326672032767;12835.294058826854;13275.734485310433;13281.269530175932;11381.203315767816;11469.541218351173;11536.192466527262;11658.358790266617;11766.470508827295;11493.310401375944;11680.415979200836;11687.123465739933;11906.821397678868;12072.517099315928;11339.773204536028;11621.825672614748;11758.941205293919;11989.580364687194;11998.940270231034;8069.112397636372;8210.876836847332;8212.917870821455;8247.134050924806;8541.658333666832;8973.865392018994;11385;12054.51781928713;12069.27584344942;12317.692057698629 10:40:18 INFO - PROCESS | 29577 | |3;mootools.html;1491.0084793612245;1505.6461731493098;1649.3897258014536;1708.651481978365;1783.420388373778;8434.66261349546;9096.818063638722;9100;9102.590383432746;9107.499087550183;7825.256600622946;8050.718224862131;8493.91506084939;8806.163414475615;8923.91076089239;2284.1091974130104;2306.850054746436;2310.249169020075;2310.7111611048617;2311.6879221305076;2292.7821856923565;2320.8027317678016;2351.6825228594175;2355.1168311883043;2360.527894421114;2259.344790010895;2273.874936878471;2287.0965968442456;2327.3832434404894;2334.054707843318;2277.6241920083166;2278.7835155660187;2282.2582660635194;2283.1209984156135;2286.222684287342;2196.5277465344866;2221.766714494971;2231.564844855254;2248.7976082152686;2254.075828910139;8511.02123255821;8552.102029286898;8559.529225892573;8561.700340488116;8568.443051201652;4956.330895329121;5097.388313402378;5097.592192624618;5101.974490127525;5105.183170692671;3208.807471551691;3238.239013831748;3390.74569407293;3392.796432214075;3396.1339858336214;1060.3743791163174;1062.4315990944885;1065.1638463805875;1073.538378497246;1092.153580974743;11825.349605771678;11861;11949.22330048544;12014.279143251346;12020.879791202064;4219.767912764827;4366.607005369468;4420.756858372821;4442.489113751895;4466.2407390743;10138.138258248131;10156.796864062677;10159.695209143738;10164.33931794431;10165.4917254137;4945.282933974626;4969.4782047884455;4970;4975.278584605285;4975.353204083446;4189.539150693421;4292.720973136736;4341.934870976938;4369.279068953587;4563.406757121553;3793.6206379362393;3818.3317919364554;3939.881803545898;3946.723729338976;3953.1698343347643;1152.2280072351546;1152.7636834448917;1153.9711507212387;1159.1827761428174;1163.365965548778;870.3428911172025;879.9692010779592;902.7156445719577;911.8221946720325;922.077922077922;5436.91844622331;5553.250311208016;5637;5657.971710141505;5691.8292451226525;364.4642375707758;369.17673587899134;371.54671301012723;371.65993116298824;376.17805095865623;3754.8310326035394;3831.6743076838225;3888.0862997195636;3889.8638547651262;3968.6031396860085;10282.897171028193;10763.085137763377;10779.13766898662;10784.89215107839;10792.46037698112;10289.43408112561;10555;10682.092022178202;10685.145188384911;10866.72833179161;7915.010623672041;8099.595020248964;8111.878321825177;8114.8782768258525;8116.797080073045;5572.526335261548;5621.80323688669;5839.299284085937;5850.268716410449;5927.673977931255;10322.948385258025;10326.638567650096;10326.793464130526;10328.638497652546;10333.689989300334;9815.901840981498;9981.401115933068;10331.741706457398;10367.688969330931;10465.476726163814;6815.42068924147;7022.332878376546;7263.927360726537;7654.272844079804;7663.118741344594;8144.226298501633;8453.788655283666;8473.27977121927;8727.956360218159;8729.127087291221;7626.466147369631;7783.455158138876;7786.961065194638;7854.332381747616;8004.319632831274;7430.96284518574;7528.096628404626;7542.509736867086;7549.547027178387;7763.961180194063;6530.934690653033;6700.430463410665;6705.597664140168;6706.262311145868;6714.496412768965;5034.496550344937;5104.081265372269;5143.71709555963;5245.816396426107;5248.501392367719;4693.671442998957;4719.2921061839625;4766.904661906673;4845.466998630219;4884.242942343943 10:40:18 INFO - PROCESS | 29577 | |4;prototype.html;315.72531897249394;321.50006739520046;324.5359136434897;328.9375018746439;329.12945259787864;5189.403218629859;5250.921236181461;5275.973620131898;5276.4987326204;5278.683279003262;5231.136862417697;5249.632525723201;5250.763715632796;5257;5261.289725887004;3904.2777086238993;4027.9597204028023;4029.7783621900785;4048.453458783071;4054.858079967202;3573.7677050991733;4053.4527838741833;4110.198511290299;4117.691173162025;4135.296999510076;4081.7755023473696;4093.3450647896343;4093.7339072960312;4095.221907837516;4099.754014759109;4089.8159582818694;4096.242195193899;4107.466029416187;4117.958820411787;4151.418801367811;3432.6910578047846;3522.5772907251294;3541.8052007139595;3558.3594952908466;3620.149264922741;5059.886824898516;5066.873328166788;5067.315912351859;5075.771590278447;5080.390353157644;4685.570900875232;4689.179393606105;4696.459907110692;4698.506656801021;4707.670463067587;5393.1101368274185;5433.804562996134;5437.918431223535;5440.939016891708;5457.945420545823;4016.7589944603124;4017.537983131948;4018.2164477926817;4022;4033.6974726895305;5379.892402151974;5554.555635549146;5652.717364131777;5711.457411545896;5759.963206622806;3990.2418540477215;4047.1298670785923;4047.4131250969035;4068.2677118119022;4081.673466122703;4111.62260642682;4125.5874412558505;4132.070284186094;4136.903720514066;4144.854930077433;4621.95378046222;4688.476245220317;4717.198076327033;4731.550502702238;4739.526047395302;5505.284313039359;5507.7246137693755;5515.751791169407;5517.420670829505;5533.648199515271;1419.6308959670353;1437.4896911596443;1437.5112461763051;1442.8485009074107;1452.1795185720246;860.8665656823077;912.8128733609594;932.7295084425576;938.7889622387181;943.5753910740194;4685.742284174403;4707.835225767081;4716.8113275468595;4717.386739723814;4728.71627702339;4927.260910863399;4942.257047338761;4943.01139772047;4949.362218769202;4961;4542.386777785023;4610.124076425468;4655.674102812771;4689.921318096789;4723.976380118077;2632.748999605348;2635.894564217448;2641.881115349814;2650.3904102056636;2654.9203523894316;5045.823396181116;5060.240963855377;5120.718360490208;5122.820701275437;5146.272475587944;5077.416097148801;5085.576038709168;5119.564836988823;5382.434844341287;5877.500412464903;5832.50423713989;5853.590248682552;5860.882782344329;5870.823875283749;5871.941280587311;5730.1977723119635;5736.110902810071;5762.193292939076;5764.221830052889;5765.394633563583;5456.127019676833;5617.382087970402;5629.437056294338;5638.238837757014;5678.829635110953;5480.725963701879;5644.181593668813;5675.290588676416;5799.420057994167;5816.302043754777;3938.0154961259686;4005.379166229239;4013;4043.6158564936286;4052.9392059119727;5627.831165065055;5698.686572238566;5721.8569535761935;5724.341700704473;5729.1119876419225;5335.759890805;5581.944180558305;5592.3009623797025;5614.915776263441;5647.745851436777;5542.501174894279;5548.668319603185;5554.583406244628;5555.333359996826;5560.27716396882;5308.336457942757;5506.394296627448;5524.530414914617;5531.308586426697;5572.35917869434;5568.220449137205;5574.581906356958;5575.358833734011;5579.637323573955;5585.664860108406;5432.837014889559;5442.319710036246;5449.400565937664;5461.590380721541;5495.972520137374 10:40:18 INFO - PROCESS | 29577 | |5;yui.html;709.9929000709993;723.6020188896106;729.5877829026598;731.8060713910811;737.1780464781766;15159.848401515981;15412.30644620992;15535.611609709735;15585.29866156023;16120;14840.628984275398;14871.958962872577;15086.698266034673;15721.528354149365;15774.290156942936;657.0636842499443;791.2957467853615;809.0857331215718;810.9229623185788;811.5779794506852;686.7356067913864;780.8047988003;798.8681867491857;809.9875156054932;812.5368539932241;855.5593869157389;857.1428571428571;857.9056303806576;858.2876212743439;858.4034096303072;695.2630211975322;855.1234984141305;855.4867079752192;855.9614817333204;856.5888373580685;529.1269405480949;599.2090440618385;618.7617767159676;624.1698540940538;624.1792043462832;14615.196164210964;14626;14649.0478118923;14652.267386630625;14658.486952956595;13213.207207567577;13800.447982080705;14092.788608170886;14213.928930355385;14509.201993890332;12525.498980040788;12612.180208286523;12875.678108047374;13009.284489353082;13355.732885342239;4408.7354758714255;4424.778761061934;4454.28731402974;4678.345031695565;4685.0395668887795;62190.68904655493;65376;66291.33708662899;76291.61854190694;76754.61622691907;11063.446827658585;11091.778164436828;11126;11249.493772780244;11450.656480305604;21007.159713611283;21045.579088418144;21066.683999740017;21110.47223819417;21141.68287475689;8493.27807136388;8503;8537.786555336166;8552.529610871337;8821;4450.35469856869;4491.528389519053;4505.594496495266;4541.8183272669385;4582.152301824107;3562.76842005274;3662.1393972416463;3687.2441149564274;3691.9077023074638;3697.556293244774;609.8627808742997;625.4496043481707;632.1592282264577;634.7302396481477;652.1912828093225;631.561065059779;643.2184895352169;646.8382904273932;660.8480049588621;669.9631520266432;9159.221466175317;9350.205232555172;9386.249100071978;9531.189848862925;9643.27675424346;538.8383484954576;629.7418058595954;640.6188317950812;664.9002649602502;693.6427739714052;4476.977615111969;4586.312053192048;4586.793594288265;4605.240135377625;4698.976505117453;70767.33861291084;90672.5466372664;91986;117691;123495;99604.50197748965;103540.48229758802;104281.47859260807;104285.47857260665;105579;87218.56390718132;90802.54598727096;93247.0675293252;93431.53284233535;93619;8537.87193192115;8615.095414981337;8688.478691278544;8837.425567338103;8853.424527405698;54330;54348;55229.447705524035;55365.723171383885;55761.721191393786;44684.10631787281;45760.313595296764;49530.75234623804;62539.6873015632;74286.62856685682;12192.695182620506;12395;12412.937935310265;12487.562935297221;12946.029047821263;13842.34936588211;13875.79186312186;14396.784048239495;14436.855631443972;14760.557183284518;12145.635630931087;12496.375181241083;12574.245545267313;12742.362881855684;12875.227486350474;13267.535636252685;13576.524821631196;13648.93175534116;13859.65350866196;14275.857241427868;12877.162984405984;13561.050726449448;13731.313434328444;13733.862661373258;14286.357113929691;10525.421101839165;10683.758553835096;10778.89221107779;11155.49800258974;11184.664460066211;9838.557264923238;9964.586518969269;10050.748731281776;11291.604793832177;11298.774024519627 10:40:18 INFO - PROCESS | 29577 | __end_tp_report 10:40:18 INFO - PROCESS | 29577 | __start_cc_report 10:40:18 INFO - PROCESS | 29577 | _x_x_mozilla_cycle_collect,1356 10:40:18 INFO - PROCESS | 29577 | __end_cc_report 10:40:18 INFO - PROCESS | 29577 | __startTimestamp1476812418774__endTimestamp 10:40:18 INFO - PROCESS | 29577 | 10:40:18 INFO - PROCESS | 29577 | ------- Summary: start ------- 10:40:18 INFO - PROCESS | 29577 | Number of tests: 6 10:40:18 INFO - PROCESS | 29577 | 10:40:18 INFO - PROCESS | 29577 | [#0] dojo.html Cycles:165 Average:5119.75 Median:5334.33 stddev:556.21 (10.4%) stddev-sans-first:531.78 10:40:18 INFO - PROCESS | 29577 | Values: 2971.7 2978.5 2986.7 3008.4 3035.3 5017.1 5087.3 5100.9 5147.1 5176.8 5122.1 5134.2 5147.9 5148.7 5152.8 4656.9 4679.0 4688.3 4729.2 4736.5 4754.6 4766.3 4798.0 4799.9 4801.5 4718.1 4744.9 4768.3 4784.9 4786.9 4750.5 4762.1 4765.6 4778.4 4843.2 4581.4 4619.8 4643.4 4701.0 4761.0 5106.2 5107.8 5116.0 5124.3 5142.2 5440.0 5460.4 5474.5 5481.6 5503.6 5282.1 5334.3 5469.6 5511.4 5512.8 5165.6 5178.8 5181.3 5234.4 5247.0 5626.6 5635.5 5643.4 5646.1 5646.5 5292.6 5357.5 5407.8 5410.9 5476.8 5406.1 5425.1 5457.4 5495.4 5531.0 5359.2 5407.3 5412.3 5414.2 5422.2 5336.6 5366.2 5419.1 5419.7 5474.1 4235.0 4269.0 4269.3 4269.6 4278.6 3820.3 3827.2 3839.3 3845.5 3858.3 5213.4 5220.4 5224.2 5227.7 5228.0 5390.6 5431.5 5438.2 5482.5 5493.8 5150.8 5222.5 5229.6 5238.3 5239.3 4738.2 4756.1 4757.3 4761.9 4812.0 5507.9 5574.1 5577.8 5579.9 5580.6 5428.1 5462.9 5485.5 5586.6 5601.6 5677.8 5684.0 5684.5 5696.7 5746.6 5471.7 5479.2 5481.3 5482.1 5486.9 5371.2 5415.8 5452.0 5457.3 5551.4 5432.7 5436.6 5438.2 5475.9 5493.3 5400.1 5402.5 5403.4 5408.7 5468.4 5246.4 5286.3 5296.9 5333.7 5340.0 5447.0 5485.1 5485.3 5539.0 5556.2 5332.1 5362.4 5374.2 5377.0 5446.9 10:40:18 INFO - PROCESS | 29577 | 10:40:18 INFO - PROCESS | 29577 | [#1] ext.html Cycles:180 Average:55575.45 Median:402788.00 stddev:106665.61 (26.5%) stddev-sans-first:106884.94 10:40:18 INFO - PROCESS | 29577 | Values: 590.6 626.1 630.3 645.8 647.7 31956.0 41026.2 42401.6 42449.2 46165.0 44220.0 44422.3 44610.8 44818.8 44878.0 8726.4 8887.2 8891.8 8894.6 8897.0 8718.0 8808.4 8808.5 8808.7 8810.9 8861.0 8909.2 8914.0 8918.4 8921.1 8780.4 8836.5 8852.2 8877.2 8885.5 8675.0 8687.7 8764.6 8766.3 8771.0 41578.8 41969.6 42044.4 42050.0 42076.6 3042.5 3298.4 3474.1 3551.7 3649.1 32182.7 32188.0 32452.0 33959.7 34011.7 3856.7 3880.3 3902.5 4050.3 4121.3 316986.0 317398.4 319897.0 320788.0 320915.0 56990.0 57278.0 57332.0 57364.4 57458.0 33913.7 35081.5 35206.3 59468.7 59603.4 13200.8 13332.8 13337.1 13342.9 13349.4 11559.2 11593.7 11594.2 11638.5 11639.2 18952.7 18988.5 19043.3 19145.6 19148.7 6950.3 7102.3 7121.4 7155.4 7203.4 781.6 905.3 919.8 939.0 999.2 30332.2 31118.4 31127.2 31669.5 32004.0 870.7 907.7 955.4 964.1 1039.1 15522.0 16485.3 16529.8 16586.4 16836.3 470998.0 471555.0 473588.0 473978.0 476009.0 56721.4 56803.4 56867.0 56884.7 57155.4 1180.5 1217.1 1223.2 1285.5 1323.0 28771.9 30786.4 32155.5 33495.5 34144.3 52682.5 53429.5 53574.7 53584.0 53585.0 400044.0 401907.0 402230.0 403346.0 405925.0 24707.6 24969.9 25072.5 25178.2 25186.4 45532.8 46553.3 46578.3 46870.0 47133.0 37655.8 38699.0 38920.4 39726.2 39814.0 38376.0 38654.0 39174.4 39983.2 40138.0 33122.0 34034.5 34493.1 34891.3 35466.1 33502.0 35916.0 36486.8 36699.1 36821.0 26447.7 27054.0 27332.9 27520.0 27748.7 10:40:18 INFO - PROCESS | 29577 | 10:40:18 INFO - PROCESS | 29577 | [#2] jquery.html Cycles:180 Average:26603.80 Median:22314.08 stddev:70739.24 (317.0%) stddev-sans-first:70910.26 10:40:18 INFO - PROCESS | 29577 | Values: 369.2 372.0 376.5 382.1 394.3 16801.7 18117.2 18178.3 18210.7 18268.0 15756.8 16138.6 16589.6 16655.8 16689.8 5441.8 5713.5 5715.9 5717.6 5717.9 4050.8 4065.6 5595.8 6291.3 6322.0 6210.0 6334.3 6345.2 6347.7 6350.0 6191.3 6267.5 6296.2 6311.7 6321.7 5456.9 5513.7 5515.3 5564.0 5569.4 22578.0 22631.8 22653.9 22732.2 22849.0 2355.4 2442.5 2571.8 2679.7 2834.6 10024.2 10502.5 10604.9 10704.0 13834.6 1884.7 1907.9 1934.6 1936.2 2061.9 77225.0 82253.0 84255.6 84869.2 85910.1 10663.4 10704.0 11047.0 11109.4 11207.7 15402.0 15423.7 15448.6 15451.5 15457.3 7438.2 7677.5 7700.0 7852.0 7935.9 7152.2 7356.5 7446.9 7549.1 7622.2 4494.4 4635.1 4695.2 4733.3 4764.2 1808.2 1817.2 1829.8 1939.3 1997.0 922.3 945.9 947.6 971.2 981.2 17896.2 18378.4 18525.0 19299.5 19681.8 908.8 944.7 947.8 984.0 986.5 10225.8 10413.6 10712.7 10721.4 10734.1 416459.0 428305.0 431704.0 431980.0 433177.0 55229.2 66166.7 84744.6 86978.0 88180.0 936.4 959.4 987.7 992.0 992.9 15661.7 16134.1 16341.3 17023.0 17353.6 37438.6 39461.2 40577.4 40650.8 41755.8 54628.5 55447.4 56851.1 57182.4 57569.1 8024.6 8116.4 8177.8 8416.7 8464.6 9286.1 12242.3 12835.3 13275.7 13281.3 11381.2 11469.5 11536.2 11658.4 11766.5 11493.3 11680.4 11687.1 11906.8 12072.5 11339.8 11621.8 11758.9 11989.6 11998.9 8069.1 8210.9 8212.9 8247.1 8541.7 8973.9 11385.0 12054.5 12069.3 12317.7 10:40:18 INFO - PROCESS | 29577 | 10:40:18 INFO - PROCESS | 29577 | [#3] mootools.html Cycles:180 Average:5652.10 Median:4317.33 stddev:3288.63 (76.2%) stddev-sans-first:3282.99 10:40:18 INFO - PROCESS | 29577 | Values: 1491.0 1505.6 1649.4 1708.7 1783.4 8434.7 9096.8 9100.0 9102.6 9107.5 7825.3 8050.7 8493.9 8806.2 8923.9 2284.1 2306.9 2310.2 2310.7 2311.7 2292.8 2320.8 2351.7 2355.1 2360.5 2259.3 2273.9 2287.1 2327.4 2334.1 2277.6 2278.8 2282.3 2283.1 2286.2 2196.5 2221.8 2231.6 2248.8 2254.1 8511.0 8552.1 8559.5 8561.7 8568.4 4956.3 5097.4 5097.6 5102.0 5105.2 3208.8 3238.2 3390.7 3392.8 3396.1 1060.4 1062.4 1065.2 1073.5 1092.2 11825.3 11861.0 11949.2 12014.3 12020.9 4219.8 4366.6 4420.8 4442.5 4466.2 10138.1 10156.8 10159.7 10164.3 10165.5 4945.3 4969.5 4970.0 4975.3 4975.4 4189.5 4292.7 4341.9 4369.3 4563.4 3793.6 3818.3 3939.9 3946.7 3953.2 1152.2 1152.8 1154.0 1159.2 1163.4 870.3 880.0 902.7 911.8 922.1 5436.9 5553.3 5637.0 5658.0 5691.8 364.5 369.2 371.5 371.7 376.2 3754.8 3831.7 3888.1 3889.9 3968.6 10282.9 10763.1 10779.1 10784.9 10792.5 10289.4 10555.0 10682.1 10685.1 10866.7 7915.0 8099.6 8111.9 8114.9 8116.8 5572.5 5621.8 5839.3 5850.3 5927.7 10322.9 10326.6 10326.8 10328.6 10333.7 9815.9 9981.4 10331.7 10367.7 10465.5 6815.4 7022.3 7263.9 7654.3 7663.1 8144.2 8453.8 8473.3 8728.0 8729.1 7626.5 7783.5 7787.0 7854.3 8004.3 7431.0 7528.1 7542.5 7549.5 7764.0 6530.9 6700.4 6705.6 6706.3 6714.5 5034.5 5104.1 5143.7 5245.8 5248.5 4693.7 4719.3 4766.9 4845.5 4884.2 10:40:18 INFO - PROCESS | 29577 | 10:40:18 INFO - PROCESS | 29577 | [#4] prototype.html Cycles:180 Average:4548.54 Median:5076.59 stddev:1341.94 (26.4%) stddev-sans-first:1307.56 10:40:18 INFO - PROCESS | 29577 | Values: 315.7 321.5 324.5 328.9 329.1 5189.4 5250.9 5276.0 5276.5 5278.7 5231.1 5249.6 5250.8 5257.0 5261.3 3904.3 4028.0 4029.8 4048.5 4054.9 3573.8 4053.5 4110.2 4117.7 4135.3 4081.8 4093.3 4093.7 4095.2 4099.8 4089.8 4096.2 4107.5 4118.0 4151.4 3432.7 3522.6 3541.8 3558.4 3620.1 5059.9 5066.9 5067.3 5075.8 5080.4 4685.6 4689.2 4696.5 4698.5 4707.7 5393.1 5433.8 5437.9 5440.9 5457.9 4016.8 4017.5 4018.2 4022.0 4033.7 5379.9 5554.6 5652.7 5711.5 5760.0 3990.2 4047.1 4047.4 4068.3 4081.7 4111.6 4125.6 4132.1 4136.9 4144.9 4622.0 4688.5 4717.2 4731.6 4739.5 5505.3 5507.7 5515.8 5517.4 5533.6 1419.6 1437.5 1437.5 1442.8 1452.2 860.9 912.8 932.7 938.8 943.6 4685.7 4707.8 4716.8 4717.4 4728.7 4927.3 4942.3 4943.0 4949.4 4961.0 4542.4 4610.1 4655.7 4689.9 4724.0 2632.7 2635.9 2641.9 2650.4 2654.9 5045.8 5060.2 5120.7 5122.8 5146.3 5077.4 5085.6 5119.6 5382.4 5877.5 5832.5 5853.6 5860.9 5870.8 5871.9 5730.2 5736.1 5762.2 5764.2 5765.4 5456.1 5617.4 5629.4 5638.2 5678.8 5480.7 5644.2 5675.3 5799.4 5816.3 3938.0 4005.4 4013.0 4043.6 4052.9 5627.8 5698.7 5721.9 5724.3 5729.1 5335.8 5581.9 5592.3 5614.9 5647.7 5542.5 5548.7 5554.6 5555.3 5560.3 5308.3 5506.4 5524.5 5531.3 5572.4 5568.2 5574.6 5575.4 5579.6 5585.7 5432.8 5442.3 5449.4 5461.6 5496.0 10:40:18 INFO - PROCESS | 29577 | 10:40:18 INFO - PROCESS | 29577 | [#5] yui.html Cycles:180 Average:19913.16 Median:4586.55 stddev:28524.77 (621.9%) stddev-sans-first:28568.35 10:40:18 INFO - PROCESS | 29577 | Values: 710.0 723.6 729.6 731.8 737.2 15159.8 15412.3 15535.6 15585.3 16120.0 14840.6 14872.0 15086.7 15721.5 15774.3 657.1 791.3 809.1 810.9 811.6 686.7 780.8 798.9 810.0 812.5 855.6 857.1 857.9 858.3 858.4 695.3 855.1 855.5 856.0 856.6 529.1 599.2 618.8 624.2 624.2 14615.2 14626.0 14649.0 14652.3 14658.5 13213.2 13800.4 14092.8 14213.9 14509.2 12525.5 12612.2 12875.7 13009.3 13355.7 4408.7 4424.8 4454.3 4678.3 4685.0 62190.7 65376.0 66291.3 76291.6 76754.6 11063.4 11091.8 11126.0 11249.5 11450.7 21007.2 21045.6 21066.7 21110.5 21141.7 8493.3 8503.0 8537.8 8552.5 8821.0 4450.4 4491.5 4505.6 4541.8 4582.2 3562.8 3662.1 3687.2 3691.9 3697.6 609.9 625.4 632.2 634.7 652.2 631.6 643.2 646.8 660.8 670.0 9159.2 9350.2 9386.2 9531.2 9643.3 538.8 629.7 640.6 664.9 693.6 4477.0 4586.3 4586.8 4605.2 4699.0 70767.3 90672.5 91986.0 117691.0 123495.0 99604.5 103540.5 104281.5 104285.5 105579.0 87218.6 90802.5 93247.1 93431.5 93619.0 8537.9 8615.1 8688.5 8837.4 8853.4 54330.0 54348.0 55229.4 55365.7 55761.7 44684.1 45760.3 49530.8 62539.7 74286.6 12192.7 12395.0 12412.9 12487.6 12946.0 13842.3 13875.8 14396.8 14436.9 14760.6 12145.6 12496.4 12574.2 12742.4 12875.2 13267.5 13576.5 13648.9 13859.7 14275.9 12877.2 13561.1 13731.3 13733.9 14286.4 10525.4 10683.8 10778.9 11155.5 11184.7 9838.6 9964.6 10050.7 11291.6 11298.8 10:40:18 INFO - PROCESS | 29577 | -------- Summary: end -------- 10:40:18 INFO - PROCESS | 29577 | 10:40:19 INFO - TEST-INFO | 29577: exit 0 10:40:19 INFO - TEST-OK | dromaeo_css | took 1117925ms 10:40:19 INFO - TEST-START | kraken 10:40:19 INFO - operating with platform_type : linux_ 10:40:19 INFO - Initialising browser for kraken test... 10:40:19 INFO - TEST-INFO | started process 29883 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpibNs1o/profile http://localhost:33232/getInfo.html) 10:40:23 INFO - PROCESS | 29883 | __metrics Screen width/height:1600/1200 10:40:23 INFO - PROCESS | 29883 | colorDepth:24 10:40:23 INFO - PROCESS | 29883 | Browser inner width/height: 1024/697 10:40:23 INFO - PROCESS | 29883 | __metrics 10:40:24 INFO - PROCESS | 29883 | 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" 10:40:24 INFO - PROCESS | 29883 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:40:25 INFO - PROCESS | 29883 | console.error: PushService: 10:40:25 INFO - PROCESS | 29883 | stateChangeProcessEnqueue: Error transitioning state 10:40:25 INFO - PROCESS | 29883 | UnknownError 10:40:25 INFO - TEST-INFO | 29883: exit 0 10:40:25 INFO - Browser initialized. 10:40:25 INFO - Running cycle 1/1 for kraken test... 10:40:25 INFO - TEST-INFO | started process 29964 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpibNs1o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:40:37 INFO - PROCESS | 29964 | RSS: Main: 172433408 10:40:37 INFO - PROCESS | 29964 | 10:40:40 INFO - PROCESS | 29964 | Cycle 1(1): loaded http://localhost:33232/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33232/tests/kraken/driver.html?testName=audio-beat-detection) 10:40:41 INFO - PROCESS | 29964 | RSS: Main: 228601856 10:40:41 INFO - PROCESS | 29964 | 10:40:43 INFO - PROCESS | 29964 | Cycle 1(1): loaded http://localhost:33232/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33232/tests/kraken/driver.html?testName=audio-dft) 10:40:44 INFO - PROCESS | 29964 | RSS: Main: 215535616 10:40:44 INFO - PROCESS | 29964 | 10:40:47 INFO - PROCESS | 29964 | Cycle 1(1): loaded http://localhost:33232/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33232/tests/kraken/driver.html?testName=audio-fft) 10:40:48 INFO - PROCESS | 29964 | RSS: Main: 297459712 10:40:48 INFO - PROCESS | 29964 | 10:40:50 INFO - PROCESS | 29964 | Cycle 1(1): loaded http://localhost:33232/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33232/tests/kraken/driver.html?testName=audio-oscillator) 10:40:50 INFO - PROCESS | 29964 | RSS: Main: 208396288 10:40:50 INFO - PROCESS | 29964 | 10:40:53 INFO - PROCESS | 29964 | Cycle 1(1): loaded http://localhost:33232/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33232/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:40:53 INFO - PROCESS | 29964 | RSS: Main: 211902464 10:40:53 INFO - PROCESS | 29964 | 10:40:56 INFO - PROCESS | 29964 | Cycle 1(1): loaded http://localhost:33232/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33232/tests/kraken/driver.html?testName=imaging-darkroom) 10:40:57 INFO - PROCESS | 29964 | RSS: Main: 247762944 10:40:57 INFO - PROCESS | 29964 | 10:41:00 INFO - PROCESS | 29964 | Cycle 1(1): loaded http://localhost:33232/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33232/tests/kraken/driver.html?testName=imaging-desaturate) 10:41:01 INFO - PROCESS | 29964 | RSS: Main: 245903360 10:41:01 INFO - PROCESS | 29964 | 10:41:03 INFO - PROCESS | 29964 | Cycle 1(1): loaded http://localhost:33232/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33232/tests/kraken/driver.html?testName=json-parse-financial) 10:41:04 INFO - PROCESS | 29964 | RSS: Main: 246505472 10:41:04 INFO - PROCESS | 29964 | 10:41:05 INFO - PROCESS | 29964 | Cycle 1(1): loaded http://localhost:33232/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33232/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:41:06 INFO - PROCESS | 29964 | RSS: Main: 208592896 10:41:06 INFO - PROCESS | 29964 | 10:41:08 INFO - PROCESS | 29964 | Cycle 1(1): loaded http://localhost:33232/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33232/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:41:08 INFO - PROCESS | 29964 | RSS: Main: 216797184 10:41:08 INFO - PROCESS | 29964 | 10:41:10 INFO - PROCESS | 29964 | Cycle 1(1): loaded http://localhost:33232/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33232/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:41:11 INFO - PROCESS | 29964 | RSS: Main: 225316864 10:41:11 INFO - PROCESS | 29964 | 10:41:14 INFO - PROCESS | 29964 | Cycle 1(1): loaded http://localhost:33232/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33232/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:41:14 INFO - PROCESS | 29964 | RSS: Main: 233967616 10:41:14 INFO - PROCESS | 29964 | 10:41:17 INFO - PROCESS | 29964 | Cycle 1(1): loaded http://localhost:33232/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33232/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:41:18 INFO - PROCESS | 29964 | RSS: Main: 231755776 10:41:18 INFO - PROCESS | 29964 | 10:41:19 INFO - PROCESS | 29964 | Cycle 1(1): loaded http://localhost:33232/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33232/tests/kraken/driver.html?testName=ai-astar) 10:41:20 INFO - PROCESS | 29964 | RSS: Main: 282030080 10:41:20 INFO - PROCESS | 29964 | 10:41:20 INFO - PROCESS | 29964 | __start_tp_report 10:41:20 INFO - PROCESS | 29964 | _x_x_mozilla_page_load 10:41:20 INFO - PROCESS | 29964 | _x_x_mozilla_page_load_details 10:41:20 INFO - PROCESS | 29964 | |i|pagename|runs| 10:41:20 INFO - PROCESS | 29964 | |0;ai-astar;103;112;111;110;111;111;112;112;110;112 10:41:20 INFO - PROCESS | 29964 | |1;audio-beat-detection;154;125;134;171;125;121;124;122;156;120 10:41:20 INFO - PROCESS | 29964 | |2;audio-dft;160;161;160;161;161;162;161;163;160;163 10:41:20 INFO - PROCESS | 29964 | |3;audio-fft;74;76;75;118;75;75;75;74;109;76 10:41:20 INFO - PROCESS | 29964 | |4;audio-oscillator;82;83;131;83;82;83;106;83;83;117 10:41:20 INFO - PROCESS | 29964 | |5;imaging-gaussian-blur;117;117;116;117;117;117;116;117;117;116 10:41:20 INFO - PROCESS | 29964 | |6;imaging-darkroom;148;146;146;147;146;146;146;146;147;146 10:41:20 INFO - PROCESS | 29964 | |7;imaging-desaturate;85;85;84;84;84;85;85;85;85;85 10:41:20 INFO - PROCESS | 29964 | |8;json-parse-financial;53;53;52;52;54;54;53;54;54;55 10:41:20 INFO - PROCESS | 29964 | |9;json-stringify-tinderbox;61;61;61;61;62;60;61;60;60;60 10:41:20 INFO - PROCESS | 29964 | |10;stanford-crypto-aes;81;79;80;80;79;79;79;79;80;81 10:41:20 INFO - PROCESS | 29964 | |11;stanford-crypto-ccm;142;138;131;139;137;144;130;134;169;128 10:41:20 INFO - PROCESS | 29964 | |12;stanford-crypto-pbkdf2;173;166;164;167;163;165;163;164;169;168 10:41:20 INFO - PROCESS | 29964 | |13;stanford-crypto-sha256-iterative;65;68;69;65;65;65;66;66;64;66 10:41:20 INFO - PROCESS | 29964 | __end_tp_report 10:41:20 INFO - PROCESS | 29964 | __start_cc_report 10:41:20 INFO - PROCESS | 29964 | _x_x_mozilla_cycle_collect,1685 10:41:20 INFO - PROCESS | 29964 | __end_cc_report 10:41:20 INFO - PROCESS | 29964 | __startTimestamp1476812480224__endTimestamp 10:41:20 INFO - PROCESS | 29964 | 10:41:20 INFO - PROCESS | 29964 | ------- Summary: start ------- 10:41:20 INFO - PROCESS | 29964 | Number of tests: 14 10:41:20 INFO - PROCESS | 29964 | 10:41:20 INFO - PROCESS | 29964 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:2.72 (2.4%) stddev-sans-first:0.83 10:41:20 INFO - PROCESS | 29964 | Values: 103.0 112.0 111.0 110.0 111.0 111.0 112.0 112.0 110.0 112.0 10:41:20 INFO - PROCESS | 29964 | 10:41:20 INFO - PROCESS | 29964 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:129.50 stddev:18.29 (14.1%) stddev-sans-first:18.09 10:41:20 INFO - PROCESS | 29964 | Values: 154.0 125.0 134.0 171.0 125.0 121.0 124.0 122.0 156.0 120.0 10:41:20 INFO - PROCESS | 29964 | 10:41:20 INFO - PROCESS | 29964 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.12 10:41:20 INFO - PROCESS | 29964 | Values: 160.0 161.0 160.0 161.0 161.0 162.0 161.0 163.0 160.0 163.0 10:41:20 INFO - PROCESS | 29964 | 10:41:20 INFO - PROCESS | 29964 | [#3] audio-fft Cycles:10 Average:82.70 Median:75.00 stddev:16.38 (21.8%) stddev-sans-first:17.07 10:41:20 INFO - PROCESS | 29964 | Values: 74.0 76.0 75.0 118.0 75.0 75.0 75.0 74.0 109.0 76.0 10:41:20 INFO - PROCESS | 29964 | 10:41:20 INFO - PROCESS | 29964 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:83.00 stddev:18.04 (21.7%) stddev-sans-first:18.67 10:41:20 INFO - PROCESS | 29964 | Values: 82.0 83.0 131.0 83.0 82.0 83.0 106.0 83.0 83.0 117.0 10:41:20 INFO - PROCESS | 29964 | 10:41:20 INFO - PROCESS | 29964 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:41:20 INFO - PROCESS | 29964 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 10:41:20 INFO - PROCESS | 29964 | 10:41:20 INFO - PROCESS | 29964 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.44 10:41:20 INFO - PROCESS | 29964 | Values: 148.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 10:41:20 INFO - PROCESS | 29964 | 10:41:20 INFO - PROCESS | 29964 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 10:41:20 INFO - PROCESS | 29964 | Values: 85.0 85.0 84.0 84.0 84.0 85.0 85.0 85.0 85.0 85.0 10:41:20 INFO - PROCESS | 29964 | 10:41:20 INFO - PROCESS | 29964 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:54.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 10:41:20 INFO - PROCESS | 29964 | Values: 53.0 53.0 52.0 52.0 54.0 54.0 53.0 54.0 54.0 55.0 10:41:20 INFO - PROCESS | 29964 | 10:41:20 INFO - PROCESS | 29964 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 10:41:20 INFO - PROCESS | 29964 | Values: 61.0 61.0 61.0 61.0 62.0 60.0 61.0 60.0 60.0 60.0 10:41:20 INFO - PROCESS | 29964 | 10:41:20 INFO - PROCESS | 29964 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:0.82 (1.0%) stddev-sans-first:0.73 10:41:20 INFO - PROCESS | 29964 | Values: 81.0 79.0 80.0 80.0 79.0 79.0 79.0 79.0 80.0 81.0 10:41:20 INFO - PROCESS | 29964 | 10:41:20 INFO - PROCESS | 29964 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:138.50 stddev:11.69 (8.4%) stddev-sans-first:12.35 10:41:20 INFO - PROCESS | 29964 | Values: 142.0 138.0 131.0 139.0 137.0 144.0 130.0 134.0 169.0 128.0 10:41:20 INFO - PROCESS | 29964 | 10:41:20 INFO - PROCESS | 29964 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:166.50 stddev:3.16 (1.9%) stddev-sans-first:2.19 10:41:20 INFO - PROCESS | 29964 | Values: 173.0 166.0 164.0 167.0 163.0 165.0 163.0 164.0 169.0 168.0 10:41:20 INFO - PROCESS | 29964 | 10:41:20 INFO - PROCESS | 29964 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.52 (2.3%) stddev-sans-first:1.58 10:41:20 INFO - PROCESS | 29964 | Values: 65.0 68.0 69.0 65.0 65.0 65.0 66.0 66.0 64.0 66.0 10:41:20 INFO - PROCESS | 29964 | -------- Summary: end -------- 10:41:20 INFO - PROCESS | 29964 | 10:41:21 INFO - TEST-INFO | 29964: exit 0 10:41:21 INFO - TEST-OK | kraken | took 61700ms 10:41:21 INFO - SUITE-END | took 1179s 10:41:21 INFO - Completed test suite (00:19:40) 10:41:21 INFO - javascript benchmark 10:41:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2971.717686819752, 2978.4787662159124, 2986.656534498532, 3008.3682426690393, 3035.2563621912623, 5017.071841709278, 5087.313212716283, 5100.872478188047, 5147.073526765181, 5176.767045482958, 5122.103631864427, 5134.229865520165, 5147.948520514794, 5148.742562871851, 5152.768125434355, 4656.930146047804, 4678.97660511697, 4688.2733176357715, 4729.172394830908, 4736.52634736527, 4754.6434017448655, 4766.261229509431, 4797.9520204797855, 4799.904001919959, 4801.495842936493, 4718.079974404993, 4744.928826067612, 4768.260919557474, 4784.856454306377, 4786.856394308176, 4750.501197374295, 4762.071396077767, 4765.594924431445, 4778.4265888093305, 4843.24929635907, 4581.3815134956685, 4619.838305659319, 4643.419572553431, 4700.976495117537, 4760.952390476085, 5106.157484015133, 5107.821226257063, 5116.0, 5124.256982737519, 5142.228665700138, 5440.020796256672, 5460.426655201187, 5474.507294343528, 5481.643693159932, 5503.587230957694, 5282.075636763551, 5334.333208348957, 5469.589780766419, 5511.366192887829, 5512.751926163332, 5165.612579056548, 5178.766955487012, 5181.326427564468, 5234.398044224925, 5247.0, 5626.606137570413, 5635.464630860061, 5643.379228284885, 5646.124850648156, 5646.491815736521, 5292.576593872481, 5357.491038351351, 5407.756650950717, 5410.891782164414, 5476.808311709071, 5406.053940560386, 5425.104857698515, 5457.399686034533, 5495.368032676293, 5531.004419204502, 5359.249705041298, 5407.297051383373, 5412.296401467784, 5414.187871819258, 5422.186671999153, 5336.573074154058, 5366.195070739421, 5419.078756611386, 5419.701916394557, 5474.069408200616, 4235.0, 4269.0, 4269.252880745919, 4269.637080848162, 4278.55075217104, 3820.2932457495453, 3827.1962887793875, 3839.2897313997, 3845.4616353710503, 3858.324793161242, 5213.40045894727, 5220.3735551734035, 5224.216367544823, 5227.738613069331, 5227.973860130675, 5390.649607775482, 5431.53831924283, 5438.15708565173, 5482.533984611273, 5493.807716729975, 5150.845474635767, 5222.503862133091, 5229.633925625246, 5238.345206849144, 5239.345081864767, 4738.19450693383, 4756.072565849695, 4757.333973243749, 4761.857144285677, 4812.013537224861, 5507.917381239205, 5574.1081426972305, 5577.776888924479, 5579.8884022320135, 5580.609357344947, 5428.104362780097, 5462.9180562292395, 5485.533729633026, 5586.553075754011, 5601.60788744784, 5677.801276955287, 5684.033714268501, 5684.488396044376, 5696.715164241854, 5746.569007324384, 5471.72641367938, 5479.178123281539, 5481.342238931354, 5482.095454250004, 5486.945130548644, 5371.194320851903, 5415.756290966995, 5452.045891968969, 5457.290552228185, 5551.365364155305, 5432.701201433959, 5436.6194366393975, 5438.15708565173, 5475.863103422446, 5493.285872836505, 5400.05499037659, 5402.486763757437, 5403.378611459575, 5408.675479471244, 5468.398476167539, 5246.396664383492, 5286.312779338661, 5296.867578310573, 5333.679979201261, 5339.973300133474, 5447.0, 5485.067538518381, 5485.286912701324, 5539.030669632718, 5556.249906262765, 5332.146856502941, 5362.410134885237, 5374.220737993047, 5376.973115134399, 5446.891062178655], "value": 5083.492179211834, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.6249531547468, 626.114048621201, 630.2972186012596, 645.7610684046904, 647.6988200486772, 31956.0, 41026.17947641049, 42401.57598424019, 42449.15101697964, 46165.0, 44220.0, 44422.33366499497, 44610.77694611523, 44818.77590612051, 44878.0, 8726.389152759293, 8887.244584210317, 8891.777705557348, 8894.555272236395, 8897.021327653953, 8718.0, 8808.383413161082, 8808.471491710518, 8808.735737927873, 8810.911890881105, 8861.0, 8909.1536304051, 8913.955430222872, 8918.375713700012, 8921.10788921106, 8780.385373023892, 8836.46981181128, 8852.247558957497, 8877.245434138105, 8885.4668719877, 8674.956625216833, 8687.652493900236, 8764.56177191138, 8766.254868336198, 8771.0, 41578.79210603928, 41969.580304196876, 42044.369334459705, 42050.0, 42076.57923420757, 3042.4675681755825, 3298.4062868683627, 3474.1488335358, 3551.662592053751, 3649.069487280753, 32182.678173218203, 32188.0, 32452.0, 33959.660403395894, 34011.659883401095, 3856.730028897978, 3880.262750077476, 3902.512185976753, 4050.331695270306, 4121.278776214151, 316986.0, 317398.4130079358, 319897.0, 320788.0, 320915.0, 56990.0, 57278.0, 57332.0, 57364.426355736745, 57458.0, 33913.660863391546, 35081.47377789335, 35206.29587408289, 59468.70265648644, 59603.403965959784, 13200.801987969997, 13332.800007999887, 13337.133086349357, 13342.93328533351, 13349.399277032557, 11559.190856640123, 11593.6521904343, 11594.246373985665, 11638.476268567934, 11639.243449175776, 18952.715709264372, 18988.525286867938, 19043.333483328017, 19145.617087658167, 19148.712769308473, 6950.339717726808, 7102.325279098477, 7121.35907768293, 7155.391791697764, 7203.38771204443, 781.5896654256561, 905.3345790843724, 919.8160367926441, 939.0187254319253, 999.195647503752, 30332.23687499368, 31118.377632447224, 31127.221819454695, 31669.52495712566, 32004.0, 870.6734974384606, 907.7140700679265, 955.4028732042474, 964.1322809471532, 1039.0752230514847, 15522.0, 16485.34058637665, 16529.83470165307, 16586.419475318307, 16836.32654693823, 470998.0, 471555.0, 473588.0, 473978.0, 476009.0, 56721.43278567244, 56803.43196568064, 56867.0, 56884.71557642268, 57155.42844571584, 1180.4628893853276, 1217.117589747426, 1223.1926928227506, 1285.5436320106414, 1322.9536966206138, 28771.85614072, 30786.38427231398, 32155.51766723548, 33495.49756753602, 34144.317113658086, 52682.473175267754, 53429.46570534245, 53574.73212634068, 53583.99999999844, 53585.0, 400044.0, 401907.0, 402230.0, 403346.0, 405925.0, 24707.62938555959, 24969.87515062413, 25072.49855002926, 25178.24465266045, 25186.37034074163, 45532.77233613811, 46553.3017004752, 46578.301325480825, 46870.0, 47133.0, 37655.81172094122, 38699.0, 38920.41619375655, 39726.20547588974, 39814.0, 38376.0, 38654.0, 39174.41238381484, 39983.2003359937, 40138.0, 33122.0316952459, 34034.489482657285, 34493.13767155841, 34891.30217395587, 35466.11334716653, 33502.0, 35916.0, 36486.817565912, 36699.08252293607, 36821.0, 26447.73552264453, 27054.0, 27332.863335683196, 27520.0, 27748.72251277542], "value": 19048.36333524431, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.21725941005064, 371.97954112523803, 376.5443812986287, 382.13446543578783, 394.29027750049903, 16801.747973780402, 18117.184726687297, 18178.272869085253, 18210.726839097406, 18268.0, 15756.763648545253, 16138.625243028997, 16589.585260368465, 16655.750163747554, 16689.83310166898, 5441.755121019553, 5713.514351280146, 5715.914261286063, 5717.571182161355, 5717.942820571782, 4050.7772072536, 4065.5527891931865, 5595.776168953257, 6291.307956124822, 6322.020086886517, 6209.975354066573, 6334.334894836045, 6345.238571371442, 6347.746090156388, 6350.0, 6191.257049154108, 6267.4986001119805, 6296.1500197473215, 6311.684415779193, 6321.715522801462, 5456.945430545684, 5513.669179849222, 5515.310586176728, 5564.026295398329, 5569.415211402785, 22578.0, 22631.77368226313, 22653.886730566406, 22732.204372847038, 22849.0, 2355.4229213842546, 2442.4504486490573, 2571.819972601919, 2679.6516452861197, 2834.6456692913384, 10024.198064154923, 10502.474876256232, 10604.893951060469, 10704.036636702735, 13834.584962451143, 1884.67960446723, 1907.895065771382, 1934.5743936333984, 1936.1964784614368, 2061.9278325258542, 77225.0, 82253.0, 84255.57872210661, 84869.15130848675, 85910.14089859083, 10663.4135122569, 10704.0, 11047.0, 11109.44452777358, 11207.71980700489, 15402.0, 15423.691526169414, 15448.613784655248, 15451.536453906401, 15457.304421301069, 7438.218987006287, 7677.539347639159, 7699.961500192463, 7852.0, 7935.920640793518, 7152.17749958751, 7356.521826081287, 7446.851062978819, 7549.0941087069905, 7622.199669034782, 4494.393256910341, 4635.119327327797, 4695.154872122982, 4733.337332773414, 4764.213904705754, 1808.2043900683657, 1817.151585326807, 1829.8288945984837, 1939.322486049557, 1996.9600607987759, 922.3359181389388, 945.8770359853175, 947.5688561704408, 971.1987610221596, 981.2248323824242, 17896.194671239824, 18378.356757513422, 18524.98112603793, 19299.51751206231, 19681.819090854595, 908.8273228086774, 944.7213072143734, 947.8436058050345, 984.0405604535521, 986.5067466266867, 10225.795484090277, 10413.5834566618, 10712.678619641423, 10721.35671859691, 10734.087602553715, 416459.0, 428305.0, 431704.0, 431980.0, 433177.0, 55229.17156242659, 66166.66916665385, 84744.57627711822, 86978.0, 88180.0, 936.4100616611491, 959.4339339789418, 987.6888780034266, 992.0426788149471, 992.9056739609725, 15661.686766264384, 16134.112623805804, 16341.346346146021, 17023.0, 17353.566160845574, 37438.62561374351, 39461.22424490847, 40577.391339130525, 40650.796746017266, 41755.7912210437, 54628.45371546234, 55447.44552554423, 56851.14723279237, 57182.42817571771, 57569.12154392347, 8024.638891250024, 8116.431849770459, 8177.754667359989, 8416.747497575083, 8464.587592536098, 9286.07139286066, 12242.326672032767, 12835.294058826854, 13275.734485310433, 13281.269530175932, 11381.203315767816, 11469.541218351173, 11536.192466527262, 11658.358790266617, 11766.470508827295, 11493.310401375944, 11680.415979200836, 11687.123465739933, 11906.821397678868, 12072.517099315928, 11339.773204536028, 11621.825672614748, 11758.941205293919, 11989.580364687194, 11998.940270231034, 8069.112397636372, 8210.876836847332, 8212.917870821455, 8247.134050924806, 8541.658333666832, 8973.865392018994, 11385.0, 12054.51781928713, 12069.27584344942, 12317.692057698629], "value": 8980.537056721236, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1491.0084793612245, 1505.6461731493098, 1649.3897258014536, 1708.651481978365, 1783.420388373778, 8434.66261349546, 9096.818063638722, 9100.0, 9102.590383432746, 9107.499087550183, 7825.256600622946, 8050.718224862131, 8493.91506084939, 8806.163414475615, 8923.91076089239, 2284.1091974130104, 2306.850054746436, 2310.249169020075, 2310.7111611048617, 2311.6879221305076, 2292.7821856923565, 2320.8027317678016, 2351.6825228594175, 2355.1168311883043, 2360.527894421114, 2259.344790010895, 2273.874936878471, 2287.0965968442456, 2327.3832434404894, 2334.054707843318, 2277.6241920083166, 2278.7835155660187, 2282.2582660635194, 2283.1209984156135, 2286.222684287342, 2196.5277465344866, 2221.766714494971, 2231.564844855254, 2248.7976082152686, 2254.075828910139, 8511.02123255821, 8552.102029286898, 8559.529225892573, 8561.700340488116, 8568.443051201652, 4956.330895329121, 5097.388313402378, 5097.592192624618, 5101.974490127525, 5105.183170692671, 3208.807471551691, 3238.239013831748, 3390.74569407293, 3392.796432214075, 3396.1339858336214, 1060.3743791163174, 1062.4315990944885, 1065.1638463805875, 1073.538378497246, 1092.153580974743, 11825.349605771678, 11861.0, 11949.22330048544, 12014.279143251346, 12020.879791202064, 4219.767912764827, 4366.607005369468, 4420.756858372821, 4442.489113751895, 4466.2407390743, 10138.138258248131, 10156.796864062677, 10159.695209143738, 10164.33931794431, 10165.4917254137, 4945.282933974626, 4969.4782047884455, 4970.0, 4975.278584605285, 4975.353204083446, 4189.539150693421, 4292.720973136736, 4341.934870976938, 4369.279068953587, 4563.406757121553, 3793.6206379362393, 3818.3317919364554, 3939.881803545898, 3946.723729338976, 3953.1698343347643, 1152.2280072351546, 1152.7636834448917, 1153.9711507212387, 1159.1827761428174, 1163.365965548778, 870.3428911172025, 879.9692010779592, 902.7156445719577, 911.8221946720325, 922.077922077922, 5436.91844622331, 5553.250311208016, 5637.0, 5657.971710141505, 5691.8292451226525, 364.4642375707758, 369.17673587899134, 371.54671301012723, 371.65993116298824, 376.17805095865623, 3754.8310326035394, 3831.6743076838225, 3888.0862997195636, 3889.8638547651262, 3968.6031396860085, 10282.897171028193, 10763.085137763377, 10779.13766898662, 10784.89215107839, 10792.46037698112, 10289.43408112561, 10555.0, 10682.092022178202, 10685.145188384911, 10866.72833179161, 7915.010623672041, 8099.595020248964, 8111.878321825177, 8114.8782768258525, 8116.797080073045, 5572.526335261548, 5621.80323688669, 5839.299284085937, 5850.268716410449, 5927.673977931255, 10322.948385258025, 10326.638567650096, 10326.793464130526, 10328.638497652546, 10333.689989300334, 9815.901840981498, 9981.401115933068, 10331.741706457398, 10367.688969330931, 10465.476726163814, 6815.42068924147, 7022.332878376546, 7263.927360726537, 7654.272844079804, 7663.118741344594, 8144.226298501633, 8453.788655283666, 8473.27977121927, 8727.956360218159, 8729.127087291221, 7626.466147369631, 7783.455158138876, 7786.961065194638, 7854.332381747616, 8004.319632831274, 7430.96284518574, 7528.096628404626, 7542.509736867086, 7549.547027178387, 7763.961180194063, 6530.934690653033, 6700.430463410665, 6705.597664140168, 6706.262311145868, 6714.496412768965, 5034.496550344937, 5104.081265372269, 5143.71709555963, 5245.816396426107, 5248.501392367719, 4693.671442998957, 4719.2921061839625, 4766.904661906673, 4845.466998630219, 4884.242942343943], "value": 4402.469402390975, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.72531897249394, 321.50006739520046, 324.5359136434897, 328.9375018746439, 329.12945259787864, 5189.403218629859, 5250.921236181461, 5275.973620131898, 5276.4987326204, 5278.683279003262, 5231.136862417697, 5249.632525723201, 5250.763715632796, 5257.0, 5261.289725887004, 3904.2777086238993, 4027.9597204028023, 4029.7783621900785, 4048.453458783071, 4054.858079967202, 3573.7677050991733, 4053.4527838741833, 4110.198511290299, 4117.691173162025, 4135.296999510076, 4081.7755023473696, 4093.3450647896343, 4093.7339072960312, 4095.221907837516, 4099.754014759109, 4089.8159582818694, 4096.242195193899, 4107.466029416187, 4117.958820411787, 4151.418801367811, 3432.6910578047846, 3522.5772907251294, 3541.8052007139595, 3558.3594952908466, 3620.149264922741, 5059.886824898516, 5066.873328166788, 5067.315912351859, 5075.771590278447, 5080.390353157644, 4685.570900875232, 4689.179393606105, 4696.459907110692, 4698.506656801021, 4707.670463067587, 5393.1101368274185, 5433.804562996134, 5437.918431223535, 5440.939016891708, 5457.945420545823, 4016.7589944603124, 4017.537983131948, 4018.2164477926817, 4022.0, 4033.6974726895305, 5379.892402151974, 5554.555635549146, 5652.717364131777, 5711.457411545896, 5759.963206622806, 3990.2418540477215, 4047.1298670785923, 4047.4131250969035, 4068.2677118119022, 4081.673466122703, 4111.62260642682, 4125.5874412558505, 4132.070284186094, 4136.903720514066, 4144.854930077433, 4621.95378046222, 4688.476245220317, 4717.198076327033, 4731.550502702238, 4739.526047395302, 5505.284313039359, 5507.7246137693755, 5515.751791169407, 5517.420670829505, 5533.648199515271, 1419.6308959670353, 1437.4896911596443, 1437.5112461763051, 1442.8485009074107, 1452.1795185720246, 860.8665656823077, 912.8128733609594, 932.7295084425576, 938.7889622387181, 943.5753910740194, 4685.742284174403, 4707.835225767081, 4716.8113275468595, 4717.386739723814, 4728.71627702339, 4927.260910863399, 4942.257047338761, 4943.01139772047, 4949.362218769202, 4961.0, 4542.386777785023, 4610.124076425468, 4655.674102812771, 4689.921318096789, 4723.976380118077, 2632.748999605348, 2635.894564217448, 2641.881115349814, 2650.3904102056636, 2654.9203523894316, 5045.823396181116, 5060.240963855377, 5120.718360490208, 5122.820701275437, 5146.272475587944, 5077.416097148801, 5085.576038709168, 5119.564836988823, 5382.434844341287, 5877.500412464903, 5832.50423713989, 5853.590248682552, 5860.882782344329, 5870.823875283749, 5871.941280587311, 5730.1977723119635, 5736.110902810071, 5762.193292939076, 5764.221830052889, 5765.394633563583, 5456.127019676833, 5617.382087970402, 5629.437056294338, 5638.238837757014, 5678.829635110953, 5480.725963701879, 5644.181593668813, 5675.290588676416, 5799.420057994167, 5816.302043754777, 3938.0154961259686, 4005.379166229239, 4013.0, 4043.6158564936286, 4052.9392059119727, 5627.831165065055, 5698.686572238566, 5721.8569535761935, 5724.341700704473, 5729.1119876419225, 5335.759890805, 5581.944180558305, 5592.3009623797025, 5614.915776263441, 5647.745851436777, 5542.501174894279, 5548.668319603185, 5554.583406244628, 5555.333359996826, 5560.27716396882, 5308.336457942757, 5506.394296627448, 5524.530414914617, 5531.308586426697, 5572.35917869434, 5568.220449137205, 5574.581906356958, 5575.358833734011, 5579.637323573955, 5585.664860108406, 5432.837014889559, 5442.319710036246, 5449.400565937664, 5461.590380721541, 5495.972520137374], "value": 4122.359544897562, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.9929000709993, 723.6020188896106, 729.5877829026598, 731.8060713910811, 737.1780464781766, 15159.848401515981, 15412.30644620992, 15535.611609709735, 15585.29866156023, 16120.0, 14840.628984275398, 14871.958962872577, 15086.698266034673, 15721.528354149365, 15774.290156942936, 657.0636842499443, 791.2957467853615, 809.0857331215718, 810.9229623185788, 811.5779794506852, 686.7356067913864, 780.8047988003, 798.8681867491857, 809.9875156054932, 812.5368539932241, 855.5593869157389, 857.1428571428571, 857.9056303806576, 858.2876212743439, 858.4034096303072, 695.2630211975322, 855.1234984141305, 855.4867079752192, 855.9614817333204, 856.5888373580685, 529.1269405480949, 599.2090440618385, 618.7617767159676, 624.1698540940538, 624.1792043462832, 14615.196164210964, 14626.0, 14649.0478118923, 14652.267386630625, 14658.486952956595, 13213.207207567577, 13800.447982080705, 14092.788608170886, 14213.928930355385, 14509.201993890332, 12525.498980040788, 12612.180208286523, 12875.678108047374, 13009.284489353082, 13355.732885342239, 4408.7354758714255, 4424.778761061934, 4454.28731402974, 4678.345031695565, 4685.0395668887795, 62190.68904655493, 65376.0, 66291.33708662899, 76291.61854190694, 76754.61622691907, 11063.446827658585, 11091.778164436828, 11126.0, 11249.493772780244, 11450.656480305604, 21007.159713611283, 21045.579088418144, 21066.683999740017, 21110.47223819417, 21141.68287475689, 8493.27807136388, 8503.0, 8537.786555336166, 8552.529610871337, 8821.0, 4450.35469856869, 4491.528389519053, 4505.594496495266, 4541.8183272669385, 4582.152301824107, 3562.76842005274, 3662.1393972416463, 3687.2441149564274, 3691.9077023074638, 3697.556293244774, 609.8627808742997, 625.4496043481707, 632.1592282264577, 634.7302396481477, 652.1912828093225, 631.561065059779, 643.2184895352169, 646.8382904273932, 660.8480049588621, 669.9631520266432, 9159.221466175317, 9350.205232555172, 9386.249100071978, 9531.189848862925, 9643.27675424346, 538.8383484954576, 629.7418058595954, 640.6188317950812, 664.9002649602502, 693.6427739714052, 4476.977615111969, 4586.312053192048, 4586.793594288265, 4605.240135377625, 4698.976505117453, 70767.33861291084, 90672.5466372664, 91986.0, 117691.0, 123495.0, 99604.50197748965, 103540.48229758802, 104281.47859260807, 104285.47857260665, 105579.0, 87218.56390718132, 90802.54598727096, 93247.0675293252, 93431.53284233535, 93619.0, 8537.87193192115, 8615.095414981337, 8688.478691278544, 8837.425567338103, 8853.424527405698, 54330.0, 54348.0, 55229.447705524035, 55365.723171383885, 55761.721191393786, 44684.10631787281, 45760.313595296764, 49530.75234623804, 62539.6873015632, 74286.62856685682, 12192.695182620506, 12395.0, 12412.937935310265, 12487.562935297221, 12946.029047821263, 13842.34936588211, 13875.79186312186, 14396.784048239495, 14436.855631443972, 14760.557183284518, 12145.635630931087, 12496.375181241083, 12574.245545267313, 12742.362881855684, 12875.227486350474, 13267.535636252685, 13576.524821631196, 13648.93175534116, 13859.65350866196, 14275.857241427868, 12877.162984405984, 13561.050726449448, 13731.313434328444, 13733.862661373258, 14286.357113929691, 10525.421101839165, 10683.758553835096, 10778.89221107779, 11155.49800258974, 11184.664460066211, 9838.557264923238, 9964.586518969269, 10050.748731281776, 11291.604793832177, 11298.774024519627], "value": 7363.932044764397, "unit": "score"}], "name": "dromaeo_css", "value": 6985.863756607218, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 111.0, 110.0, 111.0, 111.0, 112.0, 112.0, 110.0, 112.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 134.0, 171.0, 125.0, 121.0, 124.0, 122.0, 156.0, 120.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 161.0, 162.0, 161.0, 163.0, 160.0, 163.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 118.0, 75.0, 75.0, 75.0, 74.0, 109.0, 76.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 131.0, 83.0, 82.0, 83.0, 106.0, 83.0, 83.0, 117.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 52.0, 54.0, 54.0, 53.0, 54.0, 54.0, 55.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 60.0, 61.0, 60.0, 60.0, 60.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 80.0, 80.0, 79.0, 79.0, 79.0, 79.0, 80.0, 81.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 138.0, 131.0, 139.0, 137.0, 144.0, 130.0, 134.0, 169.0, 128.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 166.0, 164.0, 167.0, 163.0, 165.0, 163.0, 164.0, 169.0, 168.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 69.0, 65.0, 65.0, 65.0, 66.0, 66.0, 64.0, 66.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1495.7000000000003, "alertThreshold": 2.0}]} 10:41:21 INFO - Return code: 0 10:41:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:41:22 INFO - # TBPL SUCCESS # 10:41:22 INFO - Running post-action listener: _resource_record_post_action 10:41:22 INFO - [mozharness: 2016-10-18 17:41:22.027016Z] Finished run-tests step (success) 10:41:22 INFO - Running post-run listener: _resource_record_post_run 10:41:22 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409010176; Read time: 4; Write time: 318744 10:41:22 INFO - TinderboxPrint: CPU usage
13.1% 10:41:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 10:41:22 INFO - TinderboxPrint: I/O write bytes / time
409,010,176 / 318,744 10:41:22 INFO - TinderboxPrint: CPU idle
8,300.8 (86.9%) 10:41:22 INFO - TinderboxPrint: CPU user
1,199.8 (12.6%) 10:41:22 INFO - TinderboxPrint: Swap in / out
0 / 0 10:41:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 108113920; Read time: 0; Write time: 81040 10:41:22 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288059392; Read time: 0; Write time: 234448 10:41:22 INFO - Running post-run listener: _upload_blobber_files 10:41:22 INFO - Blob upload gear active. 10:41:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:41:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:41:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:41:23 INFO - (blobuploader) - INFO - Open directory for files ... 10:41:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:41:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:41:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:24 INFO - (blobuploader) - INFO - Done attempting. 10:41:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:41:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:41:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:27 INFO - (blobuploader) - INFO - Done attempting. 10:41:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:41:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:41:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:28 INFO - (blobuploader) - INFO - Done attempting. 10:41:28 INFO - (blobuploader) - INFO - Iteration through files over. 10:41:28 INFO - Return code: 0 10:41:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:41:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:41:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36aad1b5b3b2418cac5505cd7c3674b89e2c2790f28e161c7bf2ca620ce6db2cec6ccbf401a78e2bf05e545f99fc2e71e701a33850143537a72f5434dfe03f35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a07571b3a2a3265235a64b546fa0f09f60b73ee17ff9789bc3539cdbde048272ede2b9e6d5d69981fc238456263ebe12acaa85b89dca89469fbfdd74e88f9ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cd5d00f3e349df4b1195f87e5f5bf0116402136c0e80b7da703ae68b46392ea965092c17c3ee49e3cceb6a147047087ce1f57f1779f09038e9aa1cb7ab7e60e"} 10:41:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:41:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:41:28 INFO - Contents: 10:41:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36aad1b5b3b2418cac5505cd7c3674b89e2c2790f28e161c7bf2ca620ce6db2cec6ccbf401a78e2bf05e545f99fc2e71e701a33850143537a72f5434dfe03f35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a07571b3a2a3265235a64b546fa0f09f60b73ee17ff9789bc3539cdbde048272ede2b9e6d5d69981fc238456263ebe12acaa85b89dca89469fbfdd74e88f9ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cd5d00f3e349df4b1195f87e5f5bf0116402136c0e80b7da703ae68b46392ea965092c17c3ee49e3cceb6a147047087ce1f57f1779f09038e9aa1cb7ab7e60e"} 10:41:28 INFO - Running post-run listener: copy_logs_to_upload_dir 10:41:28 INFO - Copying logs to upload dir... 10:41:28 INFO - mkdir: /builds/slave/test/build/upload/logs 10:41:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.824333 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-18 10:41:28.708220) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 10:41:28.712408) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36aad1b5b3b2418cac5505cd7c3674b89e2c2790f28e161c7bf2ca620ce6db2cec6ccbf401a78e2bf05e545f99fc2e71e701a33850143537a72f5434dfe03f35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a07571b3a2a3265235a64b546fa0f09f60b73ee17ff9789bc3539cdbde048272ede2b9e6d5d69981fc238456263ebe12acaa85b89dca89469fbfdd74e88f9ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cd5d00f3e349df4b1195f87e5f5bf0116402136c0e80b7da703ae68b46392ea965092c17c3ee49e3cceb6a147047087ce1f57f1779f09038e9aa1cb7ab7e60e"} build_url:https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/eIadFvaBTam4RWXYjqTaVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36aad1b5b3b2418cac5505cd7c3674b89e2c2790f28e161c7bf2ca620ce6db2cec6ccbf401a78e2bf05e545f99fc2e71e701a33850143537a72f5434dfe03f35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a07571b3a2a3265235a64b546fa0f09f60b73ee17ff9789bc3539cdbde048272ede2b9e6d5d69981fc238456263ebe12acaa85b89dca89469fbfdd74e88f9ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cd5d00f3e349df4b1195f87e5f5bf0116402136c0e80b7da703ae68b46392ea965092c17c3ee49e3cceb6a147047087ce1f57f1779f09038e9aa1cb7ab7e60e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 10:41:28.744574) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 10:41:28.745169) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1476810953.61097-1082143338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 10:41:28.828132) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 10:41:28.828706) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 10:41:28.829220) ========= ========= Total master_lag: 0.19 =========