builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1484040395.94 results: success (0) buildid: 20170109234108 builduid: 548b00b206f84d6aafcc8b25872beebe revision: 0e5631748857e7df0b8e9c849fb7348f3318dfe4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 01:26:35.936733) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 01:26:35.937165) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 01:26:35.937434) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 01:26:35.952464) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 01:26:35.952795) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-10 01:26:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.3M=0s 2017-01-10 01:26:36 (88.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112682 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 01:26:36.079750) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 01:26:36.080094) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019360 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 01:26:36.130048) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 01:26:36.130399) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0e5631748857e7df0b8e9c849fb7348f3318dfe4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0e5631748857e7df0b8e9c849fb7348f3318dfe4 --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=2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-10 01:26:36,755 truncating revision to first 12 chars 2017-01-10 01:26:36,755 Setting DEBUG logging. 2017-01-10 01:26:36,756 attempt 1/10 2017-01-10 01:26:36,756 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0e5631748857?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-10 01:26:37,155 unpacking tar archive at: mozilla-aurora-0e5631748857/testing/mozharness/ program finished with exit code 0 elapsedTime=0.784257 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 01:26:36.928267) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 01:26:36.928679) ========= script_repo_revision: 0e5631748857e7df0b8e9c849fb7348f3318dfe4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 01:26:36.929093) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 01:26:36.929358) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 01:26:36.938088) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-01-10 01:26:36.938422) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:26:37 INFO - MultiFileLogger online at 20170110 01:26:37 in /builds/slave/test 01:26:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:26:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:26:37 INFO - {'append_to_log': False, 01:26:37 INFO - 'base_work_dir': '/builds/slave/test', 01:26:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:26:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:26:37 INFO - 'branch': 'Mozilla-Aurora', 01:26:37 INFO - 'buildbot_json_path': 'buildprops.json', 01:26:37 INFO - 'config_files': ('talos/linux_config.py',), 01:26:37 INFO - 'default_actions': ('clobber', 01:26:37 INFO - 'read-buildbot-config', 01:26:37 INFO - 'download-and-extract', 01:26:37 INFO - 'populate-webroot', 01:26:37 INFO - 'create-virtualenv', 01:26:37 INFO - 'install', 01:26:37 INFO - 'run-tests'), 01:26:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:26:37 INFO - 'download_minidump_stackwalk': True, 01:26:37 INFO - 'download_symbols': 'ondemand', 01:26:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:26:37 INFO - 'tooltool.py': '/tools/tooltool.py', 01:26:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:26:37 INFO - '/tools/misc-python/virtualenv.py')}, 01:26:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:26:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:26:37 INFO - 'installer_path': 'installer.exe', 01:26:37 INFO - 'log_level': 'info', 01:26:37 INFO - 'log_name': 'talos', 01:26:37 INFO - 'log_to_console': True, 01:26:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:26:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:26:37 INFO - 'opt_config_files': (), 01:26:37 INFO - 'pip_index': False, 01:26:37 INFO - 'sps_profile': False, 01:26:37 INFO - 'sps_profile_interval': 0, 01:26:37 INFO - 'suite': 'dromaeojs', 01:26:37 INFO - 'system_bits': '32', 01:26:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:26:37 INFO - 'title': 'talos-linux64-ix-012', 01:26:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:26:37 INFO - 'use_talos_json': True, 01:26:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:26:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:26:37 INFO - 'work_dir': 'build'} 01:26:37 INFO - [mozharness: 2017-01-10 09:26:37.660641Z] Running clobber step. 01:26:37 INFO - Running pre-action listener: _resource_record_pre_action 01:26:37 INFO - Running main action method: clobber 01:26:37 INFO - rmtree: /builds/slave/test/build 01:26:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:26:38 INFO - Running post-action listener: _resource_record_post_action 01:26:38 INFO - [mozharness: 2017-01-10 09:26:38.128940Z] Finished clobber step (success) 01:26:38 INFO - [mozharness: 2017-01-10 09:26:38.129040Z] Running read-buildbot-config step. 01:26:38 INFO - Running pre-action listener: _resource_record_pre_action 01:26:38 INFO - Running main action method: read_buildbot_config 01:26:38 INFO - Using buildbot properties: 01:26:38 INFO - { 01:26:38 INFO - "project": "", 01:26:38 INFO - "product": "firefox", 01:26:38 INFO - "script_repo_revision": "production", 01:26:38 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:26:38 INFO - "repository": "", 01:26:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 01:26:38 INFO - "buildid": "20170109234108", 01:26:38 INFO - "pgo_build": "True", 01:26:38 INFO - "basedir": "/builds/slave/test", 01:26:38 INFO - "buildnumber": 724, 01:26:38 INFO - "slavename": "talos-linux64-ix-012", 01:26:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:26:38 INFO - "platform": "ubuntu64_hw", 01:26:38 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 01:26:38 INFO - "branch": "mozilla-aurora", 01:26:38 INFO - "repo_path": "releases/mozilla-aurora", 01:26:38 INFO - "revision": "0e5631748857e7df0b8e9c849fb7348f3318dfe4", 01:26:38 INFO - "stage_platform": "linux64-pgo", 01:26:38 INFO - "builduid": "548b00b206f84d6aafcc8b25872beebe", 01:26:38 INFO - "slavebuilddir": "test" 01:26:38 INFO - } 01:26:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 01:26:38 INFO - Running post-action listener: _resource_record_post_action 01:26:38 INFO - [mozharness: 2017-01-10 09:26:38.131480Z] Finished read-buildbot-config step (success) 01:26:38 INFO - [mozharness: 2017-01-10 09:26:38.131569Z] Running download-and-extract step. 01:26:38 INFO - Running pre-action listener: _resource_record_pre_action 01:26:38 INFO - Running main action method: download_and_extract 01:26:38 INFO - mkdir: /builds/slave/test/build/tests 01:26:38 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')]} 01:26:38 INFO - trying https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 01:26:38 INFO - Downloading https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 01:26:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:26:38 INFO - Downloaded 1361 bytes. 01:26:38 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 01:26:38 INFO - Using the following test package requirements: 01:26:38 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 01:26:38 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:26:38 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 01:26:38 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:26:38 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 01:26:38 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:26:38 INFO - u'jsshell-linux-x86_64.zip'], 01:26:38 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:26:38 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 01:26:38 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 01:26:38 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:26:38 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 01:26:38 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:26:38 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 01:26:38 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:26:38 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 01:26:38 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:26:38 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 01:26:38 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:26:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 01:26:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:26:38 INFO - Fetch https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 01:26:39 INFO - Http code: 200 01:26:39 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 01:26:39 INFO - x-amz-cf-id: X2J0fWr0AKcslse2dvIDSTgDO9q__qIgt1Sne63OgOpvjoCQn-_cog== 01:26:39 INFO - x-amz-version-id: z5xWc.b7VkRXL_mQ9g7eXl4_d93MsNbr 01:26:39 INFO - Expected file size: 21944392 01:26:39 INFO - Obtained file size: 21944392 01:26:43 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:26:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 01:26:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:26:43 INFO - Fetch https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 01:26:44 INFO - Http code: 200 01:26:44 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 01:26:44 INFO - x-amz-cf-id: nIyclvpUtb8VWgB5HCmB6KeqIMTY7E8IiJ7whXjamiZVzH_-j0EXqg== 01:26:44 INFO - x-amz-version-id: z5xWc.b7VkRXL_mQ9g7eXl4_d93MsNbr 01:26:44 INFO - Expected file size: 21944392 01:26:44 INFO - Obtained file size: 21944392 01:26:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 01:26:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:26:48 INFO - Fetch https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 01:26:49 INFO - Http code: 200 01:26:49 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 01:26:49 INFO - x-amz-cf-id: uXdc4p7-XNq2HyUlXOlr0kgu03OU1iPr6n0nfwbSTvj-_JzY_T_NkQ== 01:26:49 INFO - x-amz-version-id: UO5E8py_bjAntutRANn23d6zSALsuUmB 01:26:49 INFO - Expected file size: 14409038 01:26:49 INFO - Obtained file size: 14409038 01:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:49 INFO - trying https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 01:26:49 INFO - Downloading https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 01:26:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:26:50 INFO - Downloaded 64096448 bytes. 01:26:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 01:26:50 INFO - mkdir: /builds/slave/test/properties 01:26:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:26:50 INFO - Writing to file /builds/slave/test/properties/build_url 01:26:50 INFO - Contents: 01:26:50 INFO - build_url:https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 01:26:51 INFO - Running post-action listener: _resource_record_post_action 01:26:51 INFO - Running post-action listener: set_extra_try_arguments 01:26:51 INFO - [mozharness: 2017-01-10 09:26:51.567361Z] Finished download-and-extract step (success) 01:26:51 INFO - [mozharness: 2017-01-10 09:26:51.567656Z] Running populate-webroot step. 01:26:51 INFO - Running pre-action listener: _resource_record_pre_action 01:26:51 INFO - Running main action method: populate_webroot 01:26:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:26:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:26:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:26:51 INFO - '--tppagecycles', 01:26:51 INFO - '7'], 01:26:51 INFO - 'tests': ['tsvgm']}}, 01:26:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:26:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:26:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:26:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:26:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:26:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:26:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:51 INFO - 'talos_options': ['--disable-e10s'], 01:26:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:26:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:26:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:51 INFO - 'talos_options': ['--disable-e10s'], 01:26:51 INFO - 'tests': ['damp', 'tps']}, 01:26:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:51 INFO - 'tests': ['damp', 'tps']}, 01:26:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:26:51 INFO - 'tests': ['dromaeo_dom']}, 01:26:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:26:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:26:51 INFO - 'tests': ['basic_compositor_video']}, 01:26:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:26:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:26:51 INFO - 'tests': ['a11yr', 01:26:51 INFO - 'ts_paint', 01:26:51 INFO - 'tpaint', 01:26:51 INFO - 'sessionrestore', 01:26:51 INFO - 'sessionrestore_no_auto_restore', 01:26:51 INFO - 'tabpaint']}, 01:26:51 INFO - 'other-e10s': {'tests': ['a11yr', 01:26:51 INFO - 'ts_paint', 01:26:51 INFO - 'tpaint', 01:26:51 INFO - 'sessionrestore', 01:26:51 INFO - 'sessionrestore_no_auto_restore', 01:26:51 INFO - 'tabpaint']}, 01:26:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:26:51 INFO - 'ts_paint', 01:26:51 INFO - 'tpaint', 01:26:51 INFO - 'sessionrestore', 01:26:51 INFO - 'sessionrestore_no_auto_restore', 01:26:51 INFO - 'tabpaint']}, 01:26:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:26:51 INFO - 'ts_paint', 01:26:51 INFO - 'tpaint', 01:26:51 INFO - 'sessionrestore', 01:26:51 INFO - 'sessionrestore_no_auto_restore', 01:26:51 INFO - 'tabpaint']}, 01:26:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:26:51 INFO - 'tests': ['a11yr', 01:26:51 INFO - 'ts_paint', 01:26:51 INFO - 'tpaint', 01:26:51 INFO - 'sessionrestore', 01:26:51 INFO - 'sessionrestore_no_auto_restore', 01:26:51 INFO - 'tabpaint']}, 01:26:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:26:51 INFO - 'tests': ['a11yr', 01:26:51 INFO - 'ts_paint', 01:26:51 INFO - 'tpaint', 01:26:51 INFO - 'sessionrestore', 01:26:51 INFO - 'sessionrestore_no_auto_restore', 01:26:51 INFO - 'tabpaint']}, 01:26:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:26:51 INFO - 'tests': ['tsvgx', 01:26:51 INFO - 'tsvgr_opacity', 01:26:51 INFO - 'tart', 01:26:51 INFO - 'tscrollx', 01:26:51 INFO - 'cart']}, 01:26:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:26:51 INFO - 'tsvgr_opacity', 01:26:51 INFO - 'tart', 01:26:51 INFO - 'tscrollx', 01:26:51 INFO - 'cart']}, 01:26:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:51 INFO - 'talos_options': ['--disable-e10s'], 01:26:51 INFO - 'tests': ['tp5o']}, 01:26:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:51 INFO - 'tests': ['tp5o']}, 01:26:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:51 INFO - 'talos_options': ['--disable-e10s', 01:26:51 INFO - '--xperf_path', 01:26:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:26:51 INFO - 'tests': ['tp5n']}, 01:26:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:51 INFO - 'talos_options': ['--xperf_path', 01:26:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:26:51 INFO - 'tests': ['tp5n']}}, 01:26:51 INFO - 'talos.zip': {'path': '', 01:26:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:26:51 INFO - Running post-action listener: _resource_record_post_action 01:26:51 INFO - [mozharness: 2017-01-10 09:26:51.587943Z] Finished populate-webroot step (success) 01:26:51 INFO - [mozharness: 2017-01-10 09:26:51.588052Z] Running create-virtualenv step. 01:26:51 INFO - Running pre-action listener: _resource_record_pre_action 01:26:51 INFO - Running main action method: create_virtualenv 01:26:51 INFO - Creating virtualenv /builds/slave/test/build/venv 01:26:51 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 01:26:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:26:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:26:51 INFO - Using real prefix '/usr' 01:26:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:26:52 INFO - Installing distribute.............................................................................................................................................................................................done. 01:26:54 INFO - Installing pip.................done. 01:26:54 INFO - Return code: 0 01:26:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:26:54 INFO - Reading from file tmpfile_stdout 01:26:54 INFO - Output received: 01:26:54 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) 01:26:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:26:54 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')]} 01:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:54 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')]} 01:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:54 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 0x7f7d664f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2093ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2090f60>, '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 0x2091d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20921d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936', '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 01:26:54 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 01:26:54 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 01:26:54 INFO - Using env: {'DISPLAY': ':0', 01:26:54 INFO - 'HOME': '/home/cltbld', 01:26:54 INFO - 'LANG': 'en_US.UTF-8', 01:26:54 INFO - 'LANGUAGE': 'en_US:en', 01:26:54 INFO - 'LOGNAME': 'cltbld', 01:26:54 INFO - 'MAIL': '/var/mail/cltbld', 01:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:54 INFO - 'MOZ_NO_REMOTE': '1', 01:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:54 INFO - 'NO_EM_RESTART': '1', 01:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:54 INFO - 'PWD': '/builds/slave/test', 01:26:54 INFO - 'SHELL': '/bin/bash', 01:26:54 INFO - 'SHLVL': '1', 01:26:54 INFO - 'TERM': 'linux', 01:26:54 INFO - 'TMOUT': '86400', 01:26:54 INFO - 'USER': 'cltbld', 01:26:54 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936', 01:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:54 INFO - '_': '/tools/buildbot/bin/python'} 01:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:54 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 01:26:54 INFO - Cleaning up... 01:26:54 INFO - Return code: 0 01:26:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:26:54 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')]} 01:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:54 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')]} 01:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:54 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 0x7f7d664f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2093ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2090f60>, '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 0x2091d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20921d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936', '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 01:26:54 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 01:26:54 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 01:26:54 INFO - Using env: {'DISPLAY': ':0', 01:26:54 INFO - 'HOME': '/home/cltbld', 01:26:54 INFO - 'LANG': 'en_US.UTF-8', 01:26:54 INFO - 'LANGUAGE': 'en_US:en', 01:26:54 INFO - 'LOGNAME': 'cltbld', 01:26:54 INFO - 'MAIL': '/var/mail/cltbld', 01:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:54 INFO - 'MOZ_NO_REMOTE': '1', 01:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:54 INFO - 'NO_EM_RESTART': '1', 01:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:54 INFO - 'PWD': '/builds/slave/test', 01:26:54 INFO - 'SHELL': '/bin/bash', 01:26:54 INFO - 'SHLVL': '1', 01:26:54 INFO - 'TERM': 'linux', 01:26:54 INFO - 'TMOUT': '86400', 01:26:54 INFO - 'USER': 'cltbld', 01:26:54 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936', 01:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:54 INFO - '_': '/tools/buildbot/bin/python'} 01:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:54 INFO - Downloading/unpacking psutil>=3.1.1 01:26:54 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 01:26:54 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 01:26:54 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 01:26:54 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 01:26:54 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 01:26:54 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 01:26:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:26:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:26:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:26:56 INFO - Installing collected packages: psutil 01:26:56 INFO - Running setup.py install for psutil 01:26:56 INFO - building 'psutil._psutil_linux' extension 01:26:56 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 01:26:57 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 01:26:57 INFO - building 'psutil._psutil_posix' extension 01:26:57 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 01:26:57 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 01:26:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:26:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:26:57 INFO - Successfully installed psutil 01:26:57 INFO - Cleaning up... 01:26:57 INFO - Return code: 0 01:26:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:26:57 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')]} 01:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:57 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')]} 01:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:57 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 0x7f7d664f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2093ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2090f60>, '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 0x2091d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20921d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936', '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 01:26:57 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 01:26:57 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 01:26:57 INFO - Using env: {'DISPLAY': ':0', 01:26:57 INFO - 'HOME': '/home/cltbld', 01:26:57 INFO - 'LANG': 'en_US.UTF-8', 01:26:57 INFO - 'LANGUAGE': 'en_US:en', 01:26:57 INFO - 'LOGNAME': 'cltbld', 01:26:57 INFO - 'MAIL': '/var/mail/cltbld', 01:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:57 INFO - 'MOZ_NO_REMOTE': '1', 01:26:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:57 INFO - 'NO_EM_RESTART': '1', 01:26:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:57 INFO - 'PWD': '/builds/slave/test', 01:26:57 INFO - 'SHELL': '/bin/bash', 01:26:57 INFO - 'SHLVL': '1', 01:26:57 INFO - 'TERM': 'linux', 01:26:57 INFO - 'TMOUT': '86400', 01:26:57 INFO - 'USER': 'cltbld', 01:26:57 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936', 01:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:57 INFO - '_': '/tools/buildbot/bin/python'} 01:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:26:57 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 01:26:57 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 01:26:57 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 01:26:57 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 01:26:57 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 01:26:57 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 01:26:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:26:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:26:59 INFO - Installing collected packages: mozsystemmonitor 01:26:59 INFO - Running setup.py install for mozsystemmonitor 01:26:59 INFO - Successfully installed mozsystemmonitor 01:26:59 INFO - Cleaning up... 01:26:59 INFO - Return code: 0 01:26:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:26: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')]} 01:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26: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')]} 01:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:59 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 0x7f7d664f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2093ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2090f60>, '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 0x2091d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20921d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936', '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 01:26:59 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 01:26:59 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 01:26:59 INFO - Using env: {'DISPLAY': ':0', 01:26:59 INFO - 'HOME': '/home/cltbld', 01:26:59 INFO - 'LANG': 'en_US.UTF-8', 01:26:59 INFO - 'LANGUAGE': 'en_US:en', 01:26:59 INFO - 'LOGNAME': 'cltbld', 01:26:59 INFO - 'MAIL': '/var/mail/cltbld', 01:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:59 INFO - 'MOZ_NO_REMOTE': '1', 01:26:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:59 INFO - 'NO_EM_RESTART': '1', 01:26:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:59 INFO - 'PWD': '/builds/slave/test', 01:26:59 INFO - 'SHELL': '/bin/bash', 01:26:59 INFO - 'SHLVL': '1', 01:26:59 INFO - 'TERM': 'linux', 01:26:59 INFO - 'TMOUT': '86400', 01:26:59 INFO - 'USER': 'cltbld', 01:26:59 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936', 01:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:59 INFO - '_': '/tools/buildbot/bin/python'} 01:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:00 INFO - Downloading/unpacking jsonschema==2.5.1 01:27:00 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 01:27:00 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 01:27:00 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 01:27:00 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 01:27:00 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 01:27:00 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 01:27:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:27:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:27:02 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 01:27:02 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 01:27:02 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 01:27:02 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 01:27:02 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 01:27:02 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 01:27:02 INFO - Downloading functools32-3.2.3-2.tar.gz 01:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:27:02 INFO - warning: no files found matching '*.txt' 01:27:02 INFO - no previously-included directories found matching 'build' 01:27:02 INFO - no previously-included directories found matching 'dist' 01:27:02 INFO - no previously-included directories found matching '.git*' 01:27:02 INFO - Installing collected packages: jsonschema, functools32 01:27:02 INFO - Running setup.py install for functools32 01:27:02 INFO - warning: no files found matching '*.txt' 01:27:02 INFO - no previously-included directories found matching 'build' 01:27:02 INFO - no previously-included directories found matching 'dist' 01:27:02 INFO - no previously-included directories found matching '.git*' 01:27:02 INFO - Successfully installed jsonschema functools32 01:27:02 INFO - Cleaning up... 01:27:02 INFO - Return code: 0 01:27:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:27:02 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')]} 01:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:02 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')]} 01:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:02 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 0x7f7d664f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2093ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2090f60>, '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 0x2091d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20921d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936', '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 01:27:02 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 01:27:02 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 01:27:02 INFO - Using env: {'DISPLAY': ':0', 01:27:02 INFO - 'HOME': '/home/cltbld', 01:27:02 INFO - 'LANG': 'en_US.UTF-8', 01:27:02 INFO - 'LANGUAGE': 'en_US:en', 01:27:02 INFO - 'LOGNAME': 'cltbld', 01:27:02 INFO - 'MAIL': '/var/mail/cltbld', 01:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:02 INFO - 'MOZ_NO_REMOTE': '1', 01:27:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:02 INFO - 'NO_EM_RESTART': '1', 01:27:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:02 INFO - 'PWD': '/builds/slave/test', 01:27:02 INFO - 'SHELL': '/bin/bash', 01:27:02 INFO - 'SHLVL': '1', 01:27:02 INFO - 'TERM': 'linux', 01:27:02 INFO - 'TMOUT': '86400', 01:27:02 INFO - 'USER': 'cltbld', 01:27:02 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936', 01:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:02 INFO - '_': '/tools/buildbot/bin/python'} 01:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:27:02 INFO - Cleaning up... 01:27:02 INFO - Return code: 0 01:27:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:27:02 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')]} 01:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:02 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')]} 01:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:02 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 0x7f7d664f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2093ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2090f60>, '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 0x2091d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20921d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936', '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 01:27:02 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 01:27:02 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 01:27:02 INFO - Using env: {'DISPLAY': ':0', 01:27:02 INFO - 'HOME': '/home/cltbld', 01:27:02 INFO - 'LANG': 'en_US.UTF-8', 01:27:02 INFO - 'LANGUAGE': 'en_US:en', 01:27:02 INFO - 'LOGNAME': 'cltbld', 01:27:02 INFO - 'MAIL': '/var/mail/cltbld', 01:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:02 INFO - 'MOZ_NO_REMOTE': '1', 01:27:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:02 INFO - 'NO_EM_RESTART': '1', 01:27:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:02 INFO - 'PWD': '/builds/slave/test', 01:27:02 INFO - 'SHELL': '/bin/bash', 01:27:02 INFO - 'SHLVL': '1', 01:27:02 INFO - 'TERM': 'linux', 01:27:02 INFO - 'TMOUT': '86400', 01:27:02 INFO - 'USER': 'cltbld', 01:27:02 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936', 01:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:02 INFO - '_': '/tools/buildbot/bin/python'} 01:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:03 INFO - Downloading/unpacking blobuploader==1.2.4 01:27:03 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 01:27:03 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 01:27:03 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 01:27:03 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 01:27:03 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 01:27:03 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 01:27:05 INFO - Downloading blobuploader-1.2.4.tar.gz 01:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:27:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:27: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 01:27: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 01:27: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 01:27: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 01:27: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 01:27: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 01:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:27:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:27: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 01:27: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 01:27: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 01:27: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 01:27: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 01:27: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 01:27:05 INFO - Downloading docopt-0.6.1.tar.gz 01:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:27:05 INFO - Installing collected packages: blobuploader, requests, docopt 01:27:05 INFO - Running setup.py install for blobuploader 01:27:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:27:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:27:05 INFO - Running setup.py install for requests 01:27:06 INFO - Running setup.py install for docopt 01:27:06 INFO - Successfully installed blobuploader requests docopt 01:27:06 INFO - Cleaning up... 01:27:06 INFO - Return code: 0 01:27:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:06 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 0x7f7d664f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2093ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2090f60>, '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 0x2091d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20921d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936', '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 01:27:06 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 01:27:06 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 01:27:06 INFO - Using env: {'DISPLAY': ':0', 01:27:06 INFO - 'HOME': '/home/cltbld', 01:27:06 INFO - 'LANG': 'en_US.UTF-8', 01:27:06 INFO - 'LANGUAGE': 'en_US:en', 01:27:06 INFO - 'LOGNAME': 'cltbld', 01:27:06 INFO - 'MAIL': '/var/mail/cltbld', 01:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:06 INFO - 'MOZ_NO_REMOTE': '1', 01:27:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:06 INFO - 'NO_EM_RESTART': '1', 01:27:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:06 INFO - 'PWD': '/builds/slave/test', 01:27:06 INFO - 'SHELL': '/bin/bash', 01:27:06 INFO - 'SHLVL': '1', 01:27:06 INFO - 'TERM': 'linux', 01:27:06 INFO - 'TMOUT': '86400', 01:27:06 INFO - 'USER': 'cltbld', 01:27:06 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936', 01:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:06 INFO - '_': '/tools/buildbot/bin/python'} 01:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:27:06 INFO - Running setup.py (path:/tmp/pip-bux8PS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:27:06 INFO - Running setup.py (path:/tmp/pip-J2AkXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:27:06 INFO - Running setup.py (path:/tmp/pip-XgO4tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:27:06 INFO - Running setup.py (path:/tmp/pip-btWccY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:27:07 INFO - Running setup.py (path:/tmp/pip-8Lmlhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:27:07 INFO - Running setup.py (path:/tmp/pip-_18L8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:27:07 INFO - Running setup.py (path:/tmp/pip-cxrW86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:27:07 INFO - Running setup.py (path:/tmp/pip-44uL6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:27:07 INFO - Running setup.py (path:/tmp/pip-mn7Pq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:27:07 INFO - Running setup.py (path:/tmp/pip-4khIKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:27:07 INFO - Running setup.py (path:/tmp/pip-e9UGRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:27:07 INFO - Running setup.py (path:/tmp/pip-eAo9dx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:27:07 INFO - Running setup.py (path:/tmp/pip-pDUjv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:27:07 INFO - Running setup.py (path:/tmp/pip-pUM1YQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:27:07 INFO - Running setup.py (path:/tmp/pip-pRwM5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:27:07 INFO - Running setup.py (path:/tmp/pip-S4_Uf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:27:07 INFO - Running setup.py (path:/tmp/pip-rbaw3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:27:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:27:07 INFO - Running setup.py install for manifestparser 01:27:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:27:08 INFO - Running setup.py install for mozcrash 01:27:08 INFO - Running setup.py install for mozdebug 01:27:08 INFO - Running setup.py install for mozdevice 01:27:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:27:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:27:08 INFO - Running setup.py install for mozfile 01:27:08 INFO - Running setup.py install for mozhttpd 01:27:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:27:08 INFO - Running setup.py install for mozinfo 01:27:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:27:08 INFO - Running setup.py install for mozInstall 01:27:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:27:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:27:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:27:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:27:08 INFO - Running setup.py install for mozleak 01:27:08 INFO - Running setup.py install for mozlog 01:27:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:27:08 INFO - Running setup.py install for moznetwork 01:27:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:27:09 INFO - Running setup.py install for mozprocess 01:27:09 INFO - Running setup.py install for mozprofile 01:27:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:27:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:27:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:27:09 INFO - Running setup.py install for mozrunner 01:27:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:27:09 INFO - Running setup.py install for mozscreenshot 01:27:09 INFO - Running setup.py install for moztest 01:27:09 INFO - Running setup.py install for mozversion 01:27:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:27:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:27:09 INFO - Cleaning up... 01:27:09 INFO - Return code: 0 01:27:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:09 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 0x7f7d664f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2093ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2090f60>, '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 0x2091d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20921d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936', '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 01:27:09 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 01:27:09 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 01:27:09 INFO - Using env: {'DISPLAY': ':0', 01:27:09 INFO - 'HOME': '/home/cltbld', 01:27:09 INFO - 'LANG': 'en_US.UTF-8', 01:27:09 INFO - 'LANGUAGE': 'en_US:en', 01:27:09 INFO - 'LOGNAME': 'cltbld', 01:27:09 INFO - 'MAIL': '/var/mail/cltbld', 01:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:09 INFO - 'MOZ_NO_REMOTE': '1', 01:27:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:09 INFO - 'NO_EM_RESTART': '1', 01:27:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:09 INFO - 'PWD': '/builds/slave/test', 01:27:09 INFO - 'SHELL': '/bin/bash', 01:27:09 INFO - 'SHLVL': '1', 01:27:09 INFO - 'TERM': 'linux', 01:27:09 INFO - 'TMOUT': '86400', 01:27:09 INFO - 'USER': 'cltbld', 01:27:09 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936', 01:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:09 INFO - '_': '/tools/buildbot/bin/python'} 01:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:27:10 INFO - Running setup.py (path:/tmp/pip-VA40sr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:27:10 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)) 01:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:27:10 INFO - Running setup.py (path:/tmp/pip-2UobqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:27:10 INFO - Running setup.py (path:/tmp/pip-VY2ul7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:27:10 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)) 01:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:27:10 INFO - Running setup.py (path:/tmp/pip-4ZHYsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:27:10 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)) 01:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:27:10 INFO - Running setup.py (path:/tmp/pip-_zrFhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:27:10 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)) 01:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:27:10 INFO - Running setup.py (path:/tmp/pip-XzCM3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:27:10 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)) 01:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:27:10 INFO - Running setup.py (path:/tmp/pip-hf1a93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:27:10 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)) 01:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:27:10 INFO - Running setup.py (path:/tmp/pip-7PtvTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:27:10 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)) 01:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:27:10 INFO - Running setup.py (path:/tmp/pip-gUk0F8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:27:10 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)) 01:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:27:10 INFO - Running setup.py (path:/tmp/pip-t7pzjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:27:10 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)) 01:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:27:10 INFO - Running setup.py (path:/tmp/pip-ryWIOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:27:10 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)) 01:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:27:10 INFO - Running setup.py (path:/tmp/pip-x5iUVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:27:10 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)) 01:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:27:10 INFO - Running setup.py (path:/tmp/pip-vbAPLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:27:10 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)) 01:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:27:10 INFO - Running setup.py (path:/tmp/pip-eqZpyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:27:11 INFO - Running setup.py (path:/tmp/pip-T0NHxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:27:11 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)) 01:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:27:11 INFO - Running setup.py (path:/tmp/pip-F900YS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 01:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:27:11 INFO - Running setup.py (path:/tmp/pip-LA365d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:27:11 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)) 01:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:27:11 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)) 01:27:11 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)) 01:27:11 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)) 01:27:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:13 INFO - Downloading blessings-1.6.tar.gz 01:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:27:13 INFO - Installing collected packages: blessings 01:27:13 INFO - Running setup.py install for blessings 01:27:13 INFO - Successfully installed blessings 01:27:13 INFO - Cleaning up... 01:27:13 INFO - Return code: 0 01:27:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:27:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:27:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:27:13 INFO - Reading from file tmpfile_stdout 01:27:13 INFO - Current package versions: 01:27:13 INFO - argparse == 1.2.1 01:27:13 INFO - blessings == 1.6 01:27:13 INFO - blobuploader == 1.2.4 01:27:13 INFO - docopt == 0.6.1 01:27:13 INFO - functools32 == 3.2.3-2 01:27:13 INFO - jsonschema == 2.5.1 01:27:13 INFO - manifestparser == 1.1 01:27:13 INFO - mozInstall == 1.12 01:27:13 INFO - mozcrash == 1.0 01:27:13 INFO - mozdebug == 0.1 01:27:13 INFO - mozdevice == 0.48 01:27:13 INFO - mozfile == 1.2 01:27:13 INFO - mozhttpd == 0.7 01:27:13 INFO - mozinfo == 0.9 01:27:13 INFO - mozleak == 0.1 01:27:13 INFO - mozlog == 3.4 01:27:13 INFO - moznetwork == 0.27 01:27:13 INFO - mozprocess == 0.23 01:27:13 INFO - mozprofile == 0.28 01:27:13 INFO - mozrunner == 6.13 01:27:13 INFO - mozscreenshot == 0.1 01:27:13 INFO - mozsystemmonitor == 0.3 01:27:13 INFO - moztest == 0.8 01:27:13 INFO - mozversion == 1.4 01:27:13 INFO - psutil == 3.1.1 01:27:13 INFO - requests == 1.2.3 01:27:13 INFO - wsgiref == 0.1.2 01:27:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:27: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')]} 01:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27: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')]} 01:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:13 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 0x7f7d664f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2093ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2090f60>, '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 0x2091d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20921d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936', '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 01:27:13 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 01:27:13 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 01:27:13 INFO - Using env: {'DISPLAY': ':0', 01:27:13 INFO - 'HOME': '/home/cltbld', 01:27:13 INFO - 'LANG': 'en_US.UTF-8', 01:27:13 INFO - 'LANGUAGE': 'en_US:en', 01:27:13 INFO - 'LOGNAME': 'cltbld', 01:27:13 INFO - 'MAIL': '/var/mail/cltbld', 01:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:13 INFO - 'MOZ_NO_REMOTE': '1', 01:27:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:13 INFO - 'NO_EM_RESTART': '1', 01:27:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:13 INFO - 'PWD': '/builds/slave/test', 01:27:13 INFO - 'SHELL': '/bin/bash', 01:27:13 INFO - 'SHLVL': '1', 01:27:13 INFO - 'TERM': 'linux', 01:27:13 INFO - 'TMOUT': '86400', 01:27:13 INFO - 'USER': 'cltbld', 01:27:13 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936', 01:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:13 INFO - '_': '/tools/buildbot/bin/python'} 01:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:13 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)) 01:27:13 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)) 01:27:13 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)) 01:27:13 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)) 01:27:13 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)) 01:27:13 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)) 01:27:13 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)) 01:27:13 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)) 01:27:13 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)) 01:27:13 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)) 01:27:13 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)) 01:27:13 INFO - Cleaning up... 01:27:13 INFO - Return code: 0 01:27:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:27: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')]} 01:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27: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')]} 01:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d664f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2093ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2090f60>, '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 0x2091d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20921d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936', '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 01:27: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', 'jsonschema'] in /builds/slave/test/build 01:27: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 jsonschema 01:27:13 INFO - Using env: {'DISPLAY': ':0', 01:27:13 INFO - 'HOME': '/home/cltbld', 01:27:13 INFO - 'LANG': 'en_US.UTF-8', 01:27:13 INFO - 'LANGUAGE': 'en_US:en', 01:27:13 INFO - 'LOGNAME': 'cltbld', 01:27:13 INFO - 'MAIL': '/var/mail/cltbld', 01:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:13 INFO - 'MOZ_NO_REMOTE': '1', 01:27:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:13 INFO - 'NO_EM_RESTART': '1', 01:27:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:13 INFO - 'PWD': '/builds/slave/test', 01:27:13 INFO - 'SHELL': '/bin/bash', 01:27:13 INFO - 'SHLVL': '1', 01:27:13 INFO - 'TERM': 'linux', 01:27:13 INFO - 'TMOUT': '86400', 01:27:13 INFO - 'USER': 'cltbld', 01:27:13 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936', 01:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:13 INFO - '_': '/tools/buildbot/bin/python'} 01:27:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:27:14 INFO - Cleaning up... 01:27:14 INFO - Return code: 0 01:27:14 INFO - Running post-action listener: _resource_record_post_action 01:27:14 INFO - Running post-action listener: _start_resource_monitoring 01:27:14 INFO - Starting resource monitoring. 01:27:14 INFO - [mozharness: 2017-01-10 09:27:14.235381Z] Finished create-virtualenv step (success) 01:27:14 INFO - [mozharness: 2017-01-10 09:27:14.235842Z] Running install step. 01:27:14 INFO - Running pre-action listener: _resource_record_pre_action 01:27:14 INFO - Running main action method: install 01:27:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:27:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:27:14 INFO - Reading from file tmpfile_stdout 01:27:14 INFO - Detecting whether we're running mozinstall >=1.0... 01:27:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:27:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:27:14 INFO - Reading from file tmpfile_stdout 01:27:14 INFO - Output received: 01:27:14 INFO - Usage: mozinstall [options] installer 01:27:14 INFO - Options: 01:27:14 INFO - -h, --help show this help message and exit 01:27:14 INFO - -d DEST, --destination=DEST 01:27:14 INFO - Directory to install application into. [default: 01:27:14 INFO - "/builds/slave/test"] 01:27:14 INFO - --app=APP Application being installed. [default: firefox] 01:27:14 INFO - mkdir: /builds/slave/test/build/application 01:27:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:27:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:27:30 INFO - Reading from file tmpfile_stdout 01:27:30 INFO - Output received: 01:27:30 INFO - /builds/slave/test/build/application/firefox/firefox 01:27:30 INFO - Running post-action listener: _resource_record_post_action 01:27:30 INFO - [mozharness: 2017-01-10 09:27:30.468931Z] Finished install step (success) 01:27:30 INFO - [mozharness: 2017-01-10 09:27:30.469174Z] Running run-tests step. 01:27:30 INFO - Running pre-action listener: _resource_record_pre_action 01:27:30 INFO - Running main action method: run_tests 01:27:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:27:30 INFO - Python 2.7.3 01:27:30 INFO - Return code: 0 01:27:30 INFO - grabbing minidump binary from tooltool 01:27:30 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')]} 01:27:30 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 0x2090f60>, '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 0x2091d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20921d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:27:30 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 01:27:30 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 01:27:30 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 01:27:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:27:30 INFO - Return code: 0 01:27:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:27:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:27:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:27:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:27:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:27:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 01:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 01:27:30 INFO - Using env: {'DISPLAY': ':0', 01:27:30 INFO - 'HOME': '/home/cltbld', 01:27:30 INFO - 'LANG': 'en_US.UTF-8', 01:27:30 INFO - 'LANGUAGE': 'en_US:en', 01:27:30 INFO - 'LOGNAME': 'cltbld', 01:27:30 INFO - 'MAIL': '/var/mail/cltbld', 01:27:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:27:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:30 INFO - 'MOZ_NO_REMOTE': '1', 01:27:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:27:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:30 INFO - 'NO_EM_RESTART': '1', 01:27:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:30 INFO - 'PWD': '/builds/slave/test', 01:27:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:27:30 INFO - 'SHELL': '/bin/bash', 01:27:30 INFO - 'SHLVL': '1', 01:27:30 INFO - 'TERM': 'linux', 01:27:30 INFO - 'TMOUT': '86400', 01:27:30 INFO - 'USER': 'cltbld', 01:27:30 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936', 01:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:30 INFO - '_': '/tools/buildbot/bin/python'} 01:27:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 01:27:30 INFO - mozversion application_buildid: 20170109234108 01:27:30 INFO - mozversion application_changeset: 0e5631748857e7df0b8e9c849fb7348f3318dfe4 01:27:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:27:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:27:30 INFO - mozversion application_name: Firefox 01:27:30 INFO - mozversion application_remotingname: firefox-dev 01:27:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:27:30 INFO - mozversion application_vendor: Mozilla 01:27:30 INFO - mozversion application_version: 52.0a2 01:27:30 INFO - mozversion platform_buildid: 20170109234108 01:27:30 INFO - mozversion platform_changeset: 0e5631748857e7df0b8e9c849fb7348f3318dfe4 01:27:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:27:30 INFO - mozversion platform_version: 52.0a2 01:27:30 INFO - using testdate: 1484040450 01:27:30 INFO - actual date: 1484040450 01:27:30 INFO - starting webserver on 'localhost:40327' 01:27:30 INFO - SUITE-START | Running 2 tests 01:27:30 INFO - TEST-START | dromaeo_css 01:27:30 INFO - operating with platform_type : linux_ 01:27:30 INFO - Initialising browser for dromaeo_css test... 01:27:30 INFO - TEST-INFO | started process 12731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL6pNSe/profile http://localhost:40327/getInfo.html) 01:27:34 INFO - PROCESS | 12731 | __metrics Screen width/height:1600/1200 01:27:34 INFO - PROCESS | 12731 | colorDepth:24 01:27:34 INFO - PROCESS | 12731 | Browser inner width/height: 1024/697 01:27:34 INFO - PROCESS | 12731 | __metrics 01:27:35 INFO - PROCESS | 12731 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:27:35 INFO - PROCESS | 12731 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:27:35 INFO - PROCESS | 12731 | console.error: PushService: 01:27:35 INFO - PROCESS | 12731 | stateChangeProcessEnqueue: Error transitioning state 01:27:35 INFO - PROCESS | 12731 | UnknownError 01:27:35 INFO - TEST-INFO | 12731: exit 0 01:27:35 INFO - Browser initialized. 01:27:35 INFO - Running cycle 1/1 for dromaeo_css test... 01:27:35 INFO - TEST-INFO | started process 12825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL6pNSe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:27:47 INFO - PROCESS | 12825 | RSS: Main: 143896576 01:27:47 INFO - PROCESS | 12825 | 01:30:49 INFO - PROCESS | 12825 | Cycle 1(1): loaded http://localhost:40327/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40327/tests/dromaeo/cssquery-ext.html) 01:30:50 INFO - PROCESS | 12825 | RSS: Main: 238833664 01:30:50 INFO - PROCESS | 12825 | 01:33:53 INFO - PROCESS | 12825 | Cycle 1(1): loaded http://localhost:40327/tests/dromaeo/cssquery-ext.html (next: http://localhost:40327/tests/dromaeo/cssquery-jquery.html) 01:33:53 INFO - PROCESS | 12825 | RSS: Main: 226439168 01:33:53 INFO - PROCESS | 12825 | 01:36:55 INFO - PROCESS | 12825 | Cycle 1(1): loaded http://localhost:40327/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40327/tests/dromaeo/cssquery-mootools.html) 01:36:56 INFO - PROCESS | 12825 | RSS: Main: 173264896 01:36:56 INFO - PROCESS | 12825 | 01:39:58 INFO - PROCESS | 12825 | Cycle 1(1): loaded http://localhost:40327/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40327/tests/dromaeo/cssquery-prototype.html) 01:39:58 INFO - PROCESS | 12825 | RSS: Main: 218755072 01:39:58 INFO - PROCESS | 12825 | 01:43:01 INFO - PROCESS | 12825 | Cycle 1(1): loaded http://localhost:40327/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40327/tests/dromaeo/cssquery-yui.html) 01:43:02 INFO - PROCESS | 12825 | RSS: Main: 173633536 01:43:02 INFO - PROCESS | 12825 | 01:46:04 INFO - PROCESS | 12825 | Cycle 1(1): loaded http://localhost:40327/tests/dromaeo/cssquery-yui.html (next: http://localhost:40327/tests/dromaeo/cssquery-dojo.html) 01:46:04 INFO - PROCESS | 12825 | RSS: Main: 243666944 01:46:04 INFO - PROCESS | 12825 | 01:46:04 INFO - PROCESS | 12825 | __start_tp_report 01:46:04 INFO - PROCESS | 12825 | _x_x_mozilla_page_load 01:46:04 INFO - PROCESS | 12825 | _x_x_mozilla_page_load_details 01:46:04 INFO - PROCESS | 12825 | |i|pagename|runs| 01:46:04 INFO - PROCESS | 12825 | |0;dojo.html;3148.7481001519873;3165.208697825543;3194.728448081913;3214.1482507135597;3231.3537292541496;5442.619016668835;5499.890002199953;5536.363318218406;5569.053260945639;5569.220309156722;5519.806806761764;5527.806526771554;5539.501444869961;5542.612017158801;5556.027695153352;4983.277424773406;5002.224655178453;5023.422306434752;5027.648064635477;5075.593952483792;5002.349694539705;5018.548330650241;5067.74661266937;5100.132977393833;5104.285400043997;5035.043341765071;5041.873953151164;5056.494350564951;5080.034793389263;5082.161443361841;5042.268871013701;5094.108531007059;5162.535371816554;5177.870553236162;5196.168613021936;4897.118518666639;4908.852734417937;5053.620978426633;5076.670016448956;5127.564157046656;5422.186671999192;5430.402655707869;5443.537299329561;5463.508284254396;5465.371482279549;5850.3564607893095;5898.675572843492;5950.077737950624;5957.434043765836;5963.165156878041;5818.0981947798155;5891.204687367193;5957.285125784933;5980.252468441445;5986.700664966735;5510.614257002011;5531.944680553223;5548.833534993957;5550.222968784374;5572.359178694421;6073.18012068374;6081.239845019372;6094.238220222473;6098.939010609837;6106.877862442815;5687.971560142256;5755.366909639936;5860.531157507389;5870.3249126350165;5875.941240587625;5895.67573783446;5897.085951677497;5906.49794767441;5985.910211346833;6017.849553761191;5941.31674857397;5951.226340575698;5955.76176952917;5959.523238140939;5997.250343707036;5760.308762948473;5904.291485021739;5950.315713692894;5962.165296858443;5962.284525856925;4514.548545145525;4524.547545245515;4544.045750392388;4559.863204103882;4564.0871825635;4091.4681091458515;4094.6314831665295;4108.876733697994;4117.814698338582;4123.814428350732;5589.664620122806;5596.608237423341;5605.1031834907035;5605.271314729059;5610.13042978339;5751.712414379264;5825.563082768809;5900.291964964146;5960.523158147338;5986.431289027535;5576.219329293902;5577.414371491016;5653.095504719226;5658.830235092953;5665.575081868877;5125.2568377585785;5127.07712611726;5131.87170320745;5142.820001299937;5152.6908385496245;6015.6691381974415;6067.029275315928;6196.47329976948;6266.968665156645;6273.466755325849;5947.31605865331;5975.940240597713;5996.580239383201;6060.818175454743;6061.454469097803;6254.8123556293385;6277.937220627735;6288.654124023223;6292.52806039558;6292.559520833498;5716.28546431696;5914.467697907209;5923.378045305181;5923.703814809329;5954.225950626391;5780.797672081457;5937.139114828412;5954.791582294599;5993.220881285405;6075.3317135115985;5863.384344643921;5890.941090589211;5893.675847828411;5893.941060589511;5899.085641725539;5874.030784920611;5880.235569375954;5887.676177810262;5888;5888.087346461305;5634.352049514195;5680.829575112753;5683.232763576864;5691.630044047124;5781.739821707949;5870.706464676835;5873.735681894411;5877.382874798255;5884.176215329943;5902.085176797603;5578;5599.8880022400135;5715.971420142872;5724.055530837365;5725.656460612377 01:46:04 INFO - PROCESS | 12825 | |1;ext.html;569.1178673056761;630.9747610095596;634.80955713286;654.5777973207281;659.8584448903395;33915.830420847895;44165.33751993719;44713;44817.32774008392;45008.54991450084;45285.32072018922;45563;45665.77167114168;45769.771151144196;45790.08419831601;8229.177082291782;8423.36824738144;8818.51498167599;8953.970293416276;8966.506842123681;10391.220658450646;10738.624148154817;10749.140068794517;10997.285176463543;11010.669679909615;10842.13262938967;10908.836367454494;10909.618163364285;10915.508802103885;10916;10720.463976801168;10770.515326810313;10776.946115269373;10777.353358798497;10786.5685372585;10711.94644026775;10780.245382823205;10780.353178809297;10781.4609269537;10782.67651970442;43097.35353969693;43326;43383.783081084395;43458.34812477815;43467.565324346986;3442.7245820334315;3485.093875592339;3519.208178159919;3598.6941110005682;4273.722208056466;31514.52728209056;32073.198170045936;32173.83913080443;32405;32485.187870303194;4195.895102622429;4489.393931819195;4506.864794056183;4554.749488778116;4630.143423466636;362903;363185;363220;363322;363336.9999999974;59603.701981489816;59795.402045979856;59957.70021149866;59971.700141499015;59982.40017599768;38780.224395511934;39772.60227397747;39957.40063899044;41747.165056698694;41800.37299440511;18349.266029358678;18619.813801862078;18634.72047919255;18647.160877760532;18662.78691885023;10386.896131038744;10474.214433917487;14041.508547201003;14371.20958347301;14425.134491930517;19946;20021.399358019284;20098.89950550238;20155.0930208141;20190.899045504677;7172.641367931583;7193.5324203926575;7238.348548630648;7257.983882256488;7317.597532135784;985.7781999050156;1026.343140390151;1065.4246706778408;1081.3565928272665;1120.4733775125678;32586.348273034408;33160.66839331624;33199.3360132796;33267;33759.83120084384;1073.3774410841693;1130.6099395708468;1131.0725205331548;1142.0863309352485;1179.4397661111075;16454.917725411535;17181.31274749021;17437.7384339235;17824.46526604204;18218.17418342163;537543;541265;543621;544274;546973;58276.70861645665;59178.11232831511;59180;59261.70369148213;59273.40726592679;1301.7656821771982;1329.8803107720157;1358.8301462317409;1405.1709491400122;1444.4005737618982;29764.85117574398;34278.82860585681;34558.06565654023;34563.30873382569;34829.477557836144;49381.25928111153;50148;50190;50190.247146293565;50240.74879625725;395896;396755;398325;399495;400718;29226.853865730536;29625.407491850474;29823.70176298209;30175.547366789076;31186.532202016533;46717.53282467268;46911.29633055439;47294;48044.51955480401;48075.438238179675;41451.58548414477;41563.7921810389;41633.37549936693;41753.79123104365;43163.56836431596;40206;40784.1843163141;41337.40719361457;41970.160596788504;42344.788276059655;41671.58328416677;42182.36726449044;42186.57813421827;42607.57392426036;42760.572394276904;34878.82560587181;36976;37040.444393333586;37311.253774924895;37650;28483.572746409234;28533.571996420487;28783.280417989718;28928.710712893444;29006.56490152607 01:46:04 INFO - PROCESS | 12825 | |2;jquery.html;399.79610398696656;418.6106920563876;425.9510156332023;429.1267271103304;442.687905026956;15109.622259443506;18929.24283028679;19064.523386915334;19478.1234844432;19759.5060123497;19489.12298946547;19547.60904781907;19994.300199492984;20094.39716808498;20494.795052049474;5485.204645326436;5702;5708.65748055118;5709.914351284734;5720.22776925114;5526.447355264481;5543.168524721304;5621.7189140542805;5636.859078523049;5648.237487939137;5607.214989901417;5616.157576363557;5618.550515958734;5621.0444224481735;5622.297212848394;5405.135178371462;5516.558675305966;5532.197831314437;5538.418466061086;5543.168524721284;4996.531572669806;5035.320231768701;5039.521245481674;5042.142835717937;5045.949540504585;23800.285991420285;24035.158769442987;24075.51848963011;24362.878185609137;24791.876040619863;2421.237310247284;2439.3657649011207;2490.9750902490923;2505.0981646607206;2535.7681754122214;14856.405743770236;14992.100473971597;15101.5469535913;15171.393144274216;15379.692406151815;1906.4757191772235;1948.9902550487157;1994.2322205950813;2002.3992802159294;2033.9694904576443;87325.99999999936;87630;88619.55690221507;88916.55541722315;89171.55414222888;9402.15380615748;10735.57057717698;11345.432728363548;12503.687112853202;12584.622461326175;13975.720485590231;14777.335019924129;14784;14809.259537023107;14825.555233343017;7386.002889609941;7885.29032387088;8608.182222688834;8699.565021749015;8887.866681999774;8552.786180345542;8814.294856411472;8870.895899116042;8979.685711000084;9152.633894644272;6650.733970641217;6865.450763938873;6944.881811047578;6993.825154371079;7024.824379390556;1749.7375393690793;1753.9473815785548;1809.5018472815725;1819.5724004858848;1840.6379279333464;942.6794889737522;996.8056229035268;1061.9150467962545;1062.7768168684509;1078.7357097511003;19853.900730496545;20302.39092827188;20430.69353959692;20462.488437789176;20618;1049.150188347441;1073.1468482556231;1079.5142186016324;1083.5394957143183;1099.4008265495324;10844.566217351376;11755.941220294015;11758.294502329887;11874.643760687193;11962.282263064244;494314;496675.83426829;505486;505647;508503;50274.748626257366;50906;54951;80750;85107.57446212853;1005.4106838586323;1029.1920842138884;1034.379372376583;1046.7435478307864;1048.067220174061;17688.55778605494;18024.819751802315;18325;18388.632227355647;18786.906065469586;28666.71333286724;36364;39109.608903911736;41059;41672.16655666809;47043;47339.52660473489;54973.17540236819;58141;58346;8503.447275927292;8556.27271681914;8684.26183774361;8816.735497935073;8906.599203036008;9726.610935562498;12851.871481285441;13047.673808154872;13178.341082946006;13635;11293.887061129284;11343.943280283545;11430.25703329281;11502.539898404304;12178.634640960785;11775.823362649739;11941.16411851162;12086.335251560897;12341.938290308492;12444;11134.3876086816;11784.292942423483;12192.329421881881;12230.816537752118;12454.937725311316;7753.651085701044;8114.310283625958;8877.73366798997;8981.191692747683;9185;11495.942520287344;11690;11785.646430607096;11887.643370698894;12046 01:46:04 INFO - PROCESS | 12825 | |3;mootools.html;1347.716979434319;1393.6933874547599;1473.2044695864233;1719.4411816159752;1721.3975108711952;7885.0932142803595;8411.242988131067;8417.326613870891;8420.284275836546;8420.410571260014;7537.510061845976;7717.961410192941;7949.205079492062;8091.757247282576;8234.588270586462;2385.487120269142;2411.2163546847255;2414;2418.383312255381;2418.830681852271;2425.4300239443714;2432.927012189637;2461.1386014894824;2470.209532949457;2472.3571871313497;2364.798992085675;2371.5612611666897;2379.512199998996;2386.3556839653284;2389.4026493376655;2331.475418030938;2356.905723771056;2359.5162991586685;2363.3737059679197;2403.495265994143;2322.047960336271;2361.8228632852433;2376.0733314007553;2378.036895057487;2381.4641705616273;8349.54077525736;8370.83258334836;8427.747167584983;8431.156884311582;8439.873401898914;5050.368703912011;5196.168613021899;5200.739963001873;5207.244949482341;5209.218617207449;3226.1128189747774;3338.4992251162275;3375;3444.225049363898;3453.861845526176;1182.5860948667898;1201.549418967887;1215.5867005218179;1218.719694470268;1242.6582689760298;11594.072474202128;11724;11765.352905590104;11771.7057073573;11775.470103845348;4223.957760422418;4484.529124441952;4543.863684089482;4647.442306923191;4657;9372.390794598467;9401.858972115424;9458.57436415363;9465.290103242147;9473.336866419422;5140.126178549655;5164.9741751291;5210.817621383233;5215.817446389358;5222.634415590872;4402.757848318373;4462.598366146997;4465.508794032654;4859.173940430064;4885.560299573055;3862.517185351831;3893.844246230176;3942.9211415772097;3979.3235150024566;3984.083660758042;1220.414201183437;1224.6264889208876;1225.2403509823966;1232.1128787273149;1255.460152134591;847.7626264645909;851.8849955255961;945.9101385368378;948.7248697877538;986.2504496582649;5610.607257492018;5676.0918253080135;5724.570657200727;5744.281964754406;5939.851503712442;459.9172149013143;468.6250999200626;469.25154378765814;472.32929240478603;474.3761953031752;3728.683061939711;3754.305453491113;3763.247350529905;3788.6211378862445;3807.961920380816;9991;10260.230482713827;10447.216458765623;10457.372557646566;10458.477076146162;10225.744356391;10322.638707645196;10362.585496580203;10374.844377334346;10381.273310868317;7970.1631328709655;8123.431359804875;8124.390670699603;8132.146124656944;8133.674653013813;5450.400455949922;5456.399796022355;5526.972365138148;5538.584606154474;5542.196381524737;9407.717768466957;9430.481323527272;9507.857382139135;9545.28410369239;9724.659636912957;9615.711528654152;9656.37233579815;9737.22102231834;9763.316567840184;9850.605975761177;6629.933700662931;6736.93263067363;7045.471589630901;7257.0565826442225;7355.1541572719825;8363.874541881754;8389.580520974048;8397.454165479225;8400.537970411442;8419.073901870912;7241.782746517613;7245.130584329703;7321.450891183076;7495.213002634645;7504.437167212372;7193.5324203926575;7320.048393708784;7387.8153046174275;7525.623718814147;7547.584882831277;6789.490788190807;6924.58452492852;6928;6937.959306104125;6940.063091482585;5105.642605017613;5156.04613146569;5174.068667639711;5189.247559103985;5297.231901374202;5115.462876398074;5262.789488420421;5267.394249661184;5270;5315.601329900351 01:46:04 INFO - PROCESS | 12825 | |4;prototype.html;344.56928838951313;358.90489020409586;360.7636997766463;362.7823306016389;363.2263279215271;5363;5487.79268560917;5518.116466926768;5522.0888553388695;5523.7238138093135;5390.6226564140525;5392.379876314225;5407.161889907071;5412.539934105596;5417.83746487605;4017.629598536863;4093.5497095319492;4321.9783901080455;4326.52898014675;4340.3489476578525;4291.339369590843;4305.935410968838;4312.849050283241;4315.136972605475;4333.2200203963275;4264.7441153530735;4272.807723652443;4278.7218830776055;4280.486341639008;4283.443152390185;4219.282721937278;4286.87139385819;4301.956980430187;4321.416608757809;4329.631981281595;3807.97184760116;3818.618138186187;3821;3859.671927886133;3877.457155998134;5277.3139491866195;5291.259223708684;5298.417174110845;5311.28297679816;5313.548348390392;4727.66906316558;4877.34155888954;4913.06651736169;4913.091078150554;4930.852074437773;5591.217229587861;5623.662580245198;5628.183913332544;5652.880169936274;5663.886722265573;4187.685923555746;4195.580441955811;4196.664266858644;4200.831966721327;4202.2646036943415;5727;5868.471837534642;5875.794347197828;5898.793542226044;5916.615419997729;4268.701190916606;4288.52826189119;4295.72077814941;4308.9353659695125;4321.783910804447;4343.283358245917;4354.303311470149;4369.956300437018;4382.474103107584;4394.846180383671;4758.476567577563;4903.901921961612;4942.332785073969;4961.181405068195;4968.478309777493;5645.5201307888465;5647.491725744702;5673.659580425187;5685.635447492572;5699.544036477072;1428.6285565752978;1451.7677171652485;1453.5464535464534;1456.9053011554215;1466.7726502392147;990.3562684255147;1026.3995562595817;1040.947952602382;1041.463646222196;1050.2858056521638;5301.68189908599;5314.7608357624;5379.65032272901;5438.510534051875;5560.888782224333;5849.853753656193;5851.795187168429;5859.275436921852;5867.911981320283;5882.264716910387;5304.946950530445;5502.752376143083;5551.250581171571;5558.416366281563;5568.805091821848;2977.568252603404;3008.3832814273023;3020.214744166489;3027.061610900628;3034.770917778259;5895.882082358329;5902.911456328158;5920.5559583031445;5958.106284057426;5994.910076348859;5546.972265138648;5748.655080695088;5768.3654797972185;5800.6356313338165;5812.534997200214;5775.393583673737;5818.42167067259;5841.474267315962;5873.471387575139;5876.412358764175;5607.775688972395;5700.714964251853;5701.116326969326;5780.479756821906;5781.797637082682;5798.797042103506;5799.101139323411;5805.390434004369;5813.3605303417435;5821.970890145522;6074.969625151846;6079.1793107931635;6103.199556130863;6181.289151747606;6191.19514463117;4215.515215750228;4268.207352911722;4275.914481710286;4279.144171165717;4310.288802347577;5802.129680547782;5813.186153938367;5834.986929509312;5866.5893387464175;5867.471927526543;5662.8301150965535;5709.23013865703;5776.191333213437;5795.1017592273265;5812.447817457335;5703.34602965152;5707.315122185364;5720.399358067343;5723.914141287801;5738.569607279387;5664.688442135557;5676.864627074684;5678.5803549112725;5680.9147862781265;5693.829185124453;5328.021169369954;5562.471565201299;5723.856903577277;5760.235087158271;5820.447057529528;5578.82844602638;5583.274174357308;5586.413426590312;5606.215129881902;5611.018071837494 01:46:04 INFO - PROCESS | 12825 | |5;yui.html;741.5810067311969;746.216472703661;747.3572727454389;811.5942028985507;867.5662168915542;13837.238951857644;14457.204853733041;14503.782443263346;14517.49188778393;14532.200728959902;14586.635334116625;14887.478938237136;14889.106653600791;14895.73386262169;14902.999999999973;708.6810935079209;721.8664547058811;839.9244068033876;853.6628031927385;865.0614083719172;832.2426591801462;839.0602525171817;839.9412041157121;840.0759164918602;840.5629072882098;887.024273299372;888.5424006636588;888.6534251641832;889.0087552379115;889.5641135843423;723.9891401628953;734.9706011759523;879.4327658660193;887.0774394629577;889.4885440871492;635.8346829824279;672.6905623413187;672.9831754206184;673.7406098652054;673.8854394752904;15104.244787760677;15193.772093418607;15206.08763474195;15208.315625796866;15211.315490802941;14327.498537551135;14339.42642294307;14502.05736627116;14567.417303307855;14608.415663373453;12670.366481675972;12716.364181790874;12728.299943503103;13079.476820927151;13185.934070329682;4433.645308375354;4447.0661161156195;4457.799399027019;4462.598366147063;4619.69971951822;67300.6634966827;67314.66342668304;67316.99024514685;67762;68121.318786812;10667.83998240027;10780.838287425695;10986.835197472044;11001.504932278067;11336.376499292619;18518.81481185171;19152.712709309373;19197.136128874234;21080.262190823247;21157.471063223235;8475.660973560989;8552.657893684307;8642.654293828176;8662.2637075848;9078.182963533314;4738.549837765407;4742.810287588527;4788.257820037899;4910.582600478928;4924.655274130848;3378.543896573931;3475.565554305712;3476.5480487536456;3478.3912815257227;3479.356319080978;608.7412849538928;621.3010363341241;636.0268788753215;640.6636515829134;647.2588885725818;753.8793792993094;758.5208842756647;778.5951305321202;782.6986610155132;808.6724876425058;9743.123118919331;9751.414915105117;9846.409215446953;9876.209903207726;9887.357321774061;679.9524033317621;755.2749360613873;763.2215140556601;774.8062984253936;794.6026986506747;4673.112108699336;4775.737334446639;4853.466118726938;4873.669487238026;4882.829100981448;87184;87845.56077219702;88640;90182.09817901737;93294;59359;64806.351936480976;65151.348486515475;66172;78610.6069469649;60702;61063;61665.38334616686;63112;63676.36323636797;9662.3719458235;9835.950820245853;10111.696649100539;10128.34165779222;10168.33905796121;37082.25835483329;42946;43835.561644383146;43879.34180987351;44547.331790023825;57594;61077;61297.693511533944;61512;63647;11421.942890285496;12177.086718495972;12290.324032178316;12399.504019839105;12501.999840012595;13475.932620336836;13596.524121655695;13795.172289662652;13915;13939.372728227458;13256.204627721982;13550.457981681016;13554.254516001714;13622.727545449234;14064.156150630995;12927.806082908952;13074.150180238254;13289.601311960656;13367;13603.795943060664;12417.192882462972;13272.27002514871;13483.865161348262;13525.59423217305;13556.525521606696;11015.614453494089;11093.889061109285;11147.537706523906;11208.439578021229;11706.1220408468;10940.56237750481;11159.832602511131;11265.324080555192;11466.82799758021;11696.532138714696 01:46:04 INFO - PROCESS | 12825 | __end_tp_report 01:46:04 INFO - PROCESS | 12825 | __start_cc_report 01:46:04 INFO - PROCESS | 12825 | _x_x_mozilla_cycle_collect,1035 01:46:04 INFO - PROCESS | 12825 | __end_cc_report 01:46:04 INFO - PROCESS | 12825 | __startTimestamp1484041564886__endTimestamp 01:46:04 INFO - PROCESS | 12825 | 01:46:04 INFO - PROCESS | 12825 | ------- Summary: start ------- 01:46:04 INFO - PROCESS | 12825 | Number of tests: 6 01:46:04 INFO - PROCESS | 12825 | 01:46:04 INFO - PROCESS | 12825 | [#0] dojo.html Cycles:165 Average:5523.93 Median:5715.97 stddev:632.21 (11.1%) stddev-sans-first:606.07 01:46:04 INFO - PROCESS | 12825 | Values: 3148.7 3165.2 3194.7 3214.1 3231.4 5442.6 5499.9 5536.4 5569.1 5569.2 5519.8 5527.8 5539.5 5542.6 5556.0 4983.3 5002.2 5023.4 5027.6 5075.6 5002.3 5018.5 5067.7 5100.1 5104.3 5035.0 5041.9 5056.5 5080.0 5082.2 5042.3 5094.1 5162.5 5177.9 5196.2 4897.1 4908.9 5053.6 5076.7 5127.6 5422.2 5430.4 5443.5 5463.5 5465.4 5850.4 5898.7 5950.1 5957.4 5963.2 5818.1 5891.2 5957.3 5980.3 5986.7 5510.6 5531.9 5548.8 5550.2 5572.4 6073.2 6081.2 6094.2 6098.9 6106.9 5688.0 5755.4 5860.5 5870.3 5875.9 5895.7 5897.1 5906.5 5985.9 6017.8 5941.3 5951.2 5955.8 5959.5 5997.3 5760.3 5904.3 5950.3 5962.2 5962.3 4514.5 4524.5 4544.0 4559.9 4564.1 4091.5 4094.6 4108.9 4117.8 4123.8 5589.7 5596.6 5605.1 5605.3 5610.1 5751.7 5825.6 5900.3 5960.5 5986.4 5576.2 5577.4 5653.1 5658.8 5665.6 5125.3 5127.1 5131.9 5142.8 5152.7 6015.7 6067.0 6196.5 6267.0 6273.5 5947.3 5975.9 5996.6 6060.8 6061.5 6254.8 6277.9 6288.7 6292.5 6292.6 5716.3 5914.5 5923.4 5923.7 5954.2 5780.8 5937.1 5954.8 5993.2 6075.3 5863.4 5890.9 5893.7 5893.9 5899.1 5874.0 5880.2 5887.7 5888.0 5888.1 5634.4 5680.8 5683.2 5691.6 5781.7 5870.7 5873.7 5877.4 5884.2 5902.1 5578.0 5599.9 5716.0 5724.1 5725.7 01:46:04 INFO - PROCESS | 12825 | 01:46:04 INFO - PROCESS | 12825 | [#1] ext.html Cycles:180 Average:59795.78 Median:37008.22 stddev:116878.79 (315.8%) stddev-sans-first:117122.08 01:46:04 INFO - PROCESS | 12825 | Values: 569.1 631.0 634.8 654.6 659.9 33915.8 44165.3 44713.0 44817.3 45008.5 45285.3 45563.0 45665.8 45769.8 45790.1 8229.2 8423.4 8818.5 8954.0 8966.5 10391.2 10738.6 10749.1 10997.3 11010.7 10842.1 10908.8 10909.6 10915.5 10916.0 10720.5 10770.5 10776.9 10777.4 10786.6 10711.9 10780.2 10780.4 10781.5 10782.7 43097.4 43326.0 43383.8 43458.3 43467.6 3442.7 3485.1 3519.2 3598.7 4273.7 31514.5 32073.2 32173.8 32405.0 32485.2 4195.9 4489.4 4506.9 4554.7 4630.1 362903.0 363185.0 363220.0 363322.0 363337.0 59603.7 59795.4 59957.7 59971.7 59982.4 38780.2 39772.6 39957.4 41747.2 41800.4 18349.3 18619.8 18634.7 18647.2 18662.8 10386.9 10474.2 14041.5 14371.2 14425.1 19946.0 20021.4 20098.9 20155.1 20190.9 7172.6 7193.5 7238.3 7258.0 7317.6 985.8 1026.3 1065.4 1081.4 1120.5 32586.3 33160.7 33199.3 33267.0 33759.8 1073.4 1130.6 1131.1 1142.1 1179.4 16454.9 17181.3 17437.7 17824.5 18218.2 537543.0 541265.0 543621.0 544274.0 546973.0 58276.7 59178.1 59180.0 59261.7 59273.4 1301.8 1329.9 1358.8 1405.2 1444.4 29764.9 34278.8 34558.1 34563.3 34829.5 49381.3 50148.0 50190.0 50190.2 50240.7 395896.0 396755.0 398325.0 399495.0 400718.0 29226.9 29625.4 29823.7 30175.5 31186.5 46717.5 46911.3 47294.0 48044.5 48075.4 41451.6 41563.8 41633.4 41753.8 43163.6 40206.0 40784.2 41337.4 41970.2 42344.8 41671.6 42182.4 42186.6 42607.6 42760.6 34878.8 36976.0 37040.4 37311.3 37650.0 28483.6 28533.6 28783.3 28928.7 29006.6 01:46:04 INFO - PROCESS | 12825 | 01:46:04 INFO - PROCESS | 12825 | [#2] jquery.html Cycles:180 Average:28825.89 Median:13401.12 stddev:82339.45 (614.4%) stddev-sans-first:82542.77 01:46:04 INFO - PROCESS | 12825 | Values: 399.8 418.6 426.0 429.1 442.7 15109.6 18929.2 19064.5 19478.1 19759.5 19489.1 19547.6 19994.3 20094.4 20494.8 5485.2 5702.0 5708.7 5709.9 5720.2 5526.4 5543.2 5621.7 5636.9 5648.2 5607.2 5616.2 5618.6 5621.0 5622.3 5405.1 5516.6 5532.2 5538.4 5543.2 4996.5 5035.3 5039.5 5042.1 5045.9 23800.3 24035.2 24075.5 24362.9 24791.9 2421.2 2439.4 2491.0 2505.1 2535.8 14856.4 14992.1 15101.5 15171.4 15379.7 1906.5 1949.0 1994.2 2002.4 2034.0 87326.0 87630.0 88619.6 88916.6 89171.6 9402.2 10735.6 11345.4 12503.7 12584.6 13975.7 14777.3 14784.0 14809.3 14825.6 7386.0 7885.3 8608.2 8699.6 8887.9 8552.8 8814.3 8870.9 8979.7 9152.6 6650.7 6865.5 6944.9 6993.8 7024.8 1749.7 1753.9 1809.5 1819.6 1840.6 942.7 996.8 1061.9 1062.8 1078.7 19853.9 20302.4 20430.7 20462.5 20618.0 1049.2 1073.1 1079.5 1083.5 1099.4 10844.6 11755.9 11758.3 11874.6 11962.3 494314.0 496675.8 505486.0 505647.0 508503.0 50274.7 50906.0 54951.0 80750.0 85107.6 1005.4 1029.2 1034.4 1046.7 1048.1 17688.6 18024.8 18325.0 18388.6 18786.9 28666.7 36364.0 39109.6 41059.0 41672.2 47043.0 47339.5 54973.2 58141.0 58346.0 8503.4 8556.3 8684.3 8816.7 8906.6 9726.6 12851.9 13047.7 13178.3 13635.0 11293.9 11343.9 11430.3 11502.5 12178.6 11775.8 11941.2 12086.3 12341.9 12444.0 11134.4 11784.3 12192.3 12230.8 12454.9 7753.7 8114.3 8877.7 8981.2 9185.0 11495.9 11690.0 11785.6 11887.6 12046.0 01:46:04 INFO - PROCESS | 12825 | 01:46:04 INFO - PROCESS | 12825 | [#3] mootools.html Cycles:180 Average:5566.67 Median:5181.66 stddev:3094.54 (59.7%) stddev-sans-first:3086.98 01:46:04 INFO - PROCESS | 12825 | Values: 1347.7 1393.7 1473.2 1719.4 1721.4 7885.1 8411.2 8417.3 8420.3 8420.4 7537.5 7718.0 7949.2 8091.8 8234.6 2385.5 2411.2 2414.0 2418.4 2418.8 2425.4 2432.9 2461.1 2470.2 2472.4 2364.8 2371.6 2379.5 2386.4 2389.4 2331.5 2356.9 2359.5 2363.4 2403.5 2322.0 2361.8 2376.1 2378.0 2381.5 8349.5 8370.8 8427.7 8431.2 8439.9 5050.4 5196.2 5200.7 5207.2 5209.2 3226.1 3338.5 3375.0 3444.2 3453.9 1182.6 1201.5 1215.6 1218.7 1242.7 11594.1 11724.0 11765.4 11771.7 11775.5 4224.0 4484.5 4543.9 4647.4 4657.0 9372.4 9401.9 9458.6 9465.3 9473.3 5140.1 5165.0 5210.8 5215.8 5222.6 4402.8 4462.6 4465.5 4859.2 4885.6 3862.5 3893.8 3942.9 3979.3 3984.1 1220.4 1224.6 1225.2 1232.1 1255.5 847.8 851.9 945.9 948.7 986.3 5610.6 5676.1 5724.6 5744.3 5939.9 459.9 468.6 469.3 472.3 474.4 3728.7 3754.3 3763.2 3788.6 3808.0 9991.0 10260.2 10447.2 10457.4 10458.5 10225.7 10322.6 10362.6 10374.8 10381.3 7970.2 8123.4 8124.4 8132.1 8133.7 5450.4 5456.4 5527.0 5538.6 5542.2 9407.7 9430.5 9507.9 9545.3 9724.7 9615.7 9656.4 9737.2 9763.3 9850.6 6629.9 6736.9 7045.5 7257.1 7355.2 8363.9 8389.6 8397.5 8400.5 8419.1 7241.8 7245.1 7321.5 7495.2 7504.4 7193.5 7320.0 7387.8 7525.6 7547.6 6789.5 6924.6 6928.0 6938.0 6940.1 5105.6 5156.0 5174.1 5189.2 5297.2 5115.5 5262.8 5267.4 5270.0 5315.6 01:46:04 INFO - PROCESS | 12825 | 01:46:04 INFO - PROCESS | 12825 | [#4] prototype.html Cycles:180 Average:4810.49 Median:5463.15 stddev:1388.26 (25.4%) stddev-sans-first:1351.08 01:46:04 INFO - PROCESS | 12825 | Values: 344.6 358.9 360.8 362.8 363.2 5363.0 5487.8 5518.1 5522.1 5523.7 5390.6 5392.4 5407.2 5412.5 5417.8 4017.6 4093.5 4322.0 4326.5 4340.3 4291.3 4305.9 4312.8 4315.1 4333.2 4264.7 4272.8 4278.7 4280.5 4283.4 4219.3 4286.9 4302.0 4321.4 4329.6 3808.0 3818.6 3821.0 3859.7 3877.5 5277.3 5291.3 5298.4 5311.3 5313.5 4727.7 4877.3 4913.1 4913.1 4930.9 5591.2 5623.7 5628.2 5652.9 5663.9 4187.7 4195.6 4196.7 4200.8 4202.3 5727.0 5868.5 5875.8 5898.8 5916.6 4268.7 4288.5 4295.7 4308.9 4321.8 4343.3 4354.3 4370.0 4382.5 4394.8 4758.5 4903.9 4942.3 4961.2 4968.5 5645.5 5647.5 5673.7 5685.6 5699.5 1428.6 1451.8 1453.5 1456.9 1466.8 990.4 1026.4 1040.9 1041.5 1050.3 5301.7 5314.8 5379.7 5438.5 5560.9 5849.9 5851.8 5859.3 5867.9 5882.3 5304.9 5502.8 5551.3 5558.4 5568.8 2977.6 3008.4 3020.2 3027.1 3034.8 5895.9 5902.9 5920.6 5958.1 5994.9 5547.0 5748.7 5768.4 5800.6 5812.5 5775.4 5818.4 5841.5 5873.5 5876.4 5607.8 5700.7 5701.1 5780.5 5781.8 5798.8 5799.1 5805.4 5813.4 5822.0 6075.0 6079.2 6103.2 6181.3 6191.2 4215.5 4268.2 4275.9 4279.1 4310.3 5802.1 5813.2 5835.0 5866.6 5867.5 5662.8 5709.2 5776.2 5795.1 5812.4 5703.3 5707.3 5720.4 5723.9 5738.6 5664.7 5676.9 5678.6 5680.9 5693.8 5328.0 5562.5 5723.9 5760.2 5820.4 5578.8 5583.3 5586.4 5606.2 5611.0 01:46:04 INFO - PROCESS | 12825 | 01:46:04 INFO - PROCESS | 12825 | [#5] yui.html Cycles:180 Average:17594.99 Median:4759.27 stddev:22637.58 (475.7%) stddev-sans-first:22665.71 01:46:04 INFO - PROCESS | 12825 | Values: 741.6 746.2 747.4 811.6 867.6 13837.2 14457.2 14503.8 14517.5 14532.2 14586.6 14887.5 14889.1 14895.7 14903.0 708.7 721.9 839.9 853.7 865.1 832.2 839.1 839.9 840.1 840.6 887.0 888.5 888.7 889.0 889.6 724.0 735.0 879.4 887.1 889.5 635.8 672.7 673.0 673.7 673.9 15104.2 15193.8 15206.1 15208.3 15211.3 14327.5 14339.4 14502.1 14567.4 14608.4 12670.4 12716.4 12728.3 13079.5 13185.9 4433.6 4447.1 4457.8 4462.6 4619.7 67300.7 67314.7 67317.0 67762.0 68121.3 10667.8 10780.8 10986.8 11001.5 11336.4 18518.8 19152.7 19197.1 21080.3 21157.5 8475.7 8552.7 8642.7 8662.3 9078.2 4738.5 4742.8 4788.3 4910.6 4924.7 3378.5 3475.6 3476.5 3478.4 3479.4 608.7 621.3 636.0 640.7 647.3 753.9 758.5 778.6 782.7 808.7 9743.1 9751.4 9846.4 9876.2 9887.4 680.0 755.3 763.2 774.8 794.6 4673.1 4775.7 4853.5 4873.7 4882.8 87184.0 87845.6 88640.0 90182.1 93294.0 59359.0 64806.4 65151.3 66172.0 78610.6 60702.0 61063.0 61665.4 63112.0 63676.4 9662.4 9836.0 10111.7 10128.3 10168.3 37082.3 42946.0 43835.6 43879.3 44547.3 57594.0 61077.0 61297.7 61512.0 63647.0 11421.9 12177.1 12290.3 12399.5 12502.0 13475.9 13596.5 13795.2 13915.0 13939.4 13256.2 13550.5 13554.3 13622.7 14064.2 12927.8 13074.2 13289.6 13367.0 13603.8 12417.2 13272.3 13483.9 13525.6 13556.5 11015.6 11093.9 11147.5 11208.4 11706.1 10940.6 11159.8 11265.3 11466.8 11696.5 01:46:04 INFO - PROCESS | 12825 | -------- Summary: end -------- 01:46:04 INFO - PROCESS | 12825 | 01:46:05 INFO - TEST-INFO | 12825: exit 0 01:46:05 INFO - TEST-OK | dromaeo_css | took 1114885ms 01:46:05 INFO - TEST-START | kraken 01:46:05 INFO - operating with platform_type : linux_ 01:46:05 INFO - Initialising browser for kraken test... 01:46:05 INFO - TEST-INFO | started process 13145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOK56kE/profile http://localhost:40327/getInfo.html) 01:46:09 INFO - PROCESS | 13145 | __metrics Screen width/height:1600/1200 01:46:09 INFO - PROCESS | 13145 | colorDepth:24 01:46:09 INFO - PROCESS | 13145 | Browser inner width/height: 1024/697 01:46:09 INFO - PROCESS | 13145 | __metrics 01:46:09 INFO - PROCESS | 13145 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:46:09 INFO - PROCESS | 13145 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:46:10 INFO - PROCESS | 13145 | console.error: PushService: 01:46:10 INFO - PROCESS | 13145 | stateChangeProcessEnqueue: Error transitioning state 01:46:10 INFO - PROCESS | 13145 | UnknownError 01:46:10 INFO - TEST-INFO | 13145: exit 0 01:46:10 INFO - Browser initialized. 01:46:10 INFO - Running cycle 1/1 for kraken test... 01:46:10 INFO - TEST-INFO | started process 13239 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOK56kE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:46:22 INFO - PROCESS | 13239 | RSS: Main: 143642624 01:46:22 INFO - PROCESS | 13239 | 01:46:25 INFO - PROCESS | 13239 | Cycle 1(1): loaded http://localhost:40327/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40327/tests/kraken/driver.html?testName=audio-beat-detection) 01:46:25 INFO - PROCESS | 13239 | RSS: Main: 185810944 01:46:25 INFO - PROCESS | 13239 | 01:46:28 INFO - PROCESS | 13239 | Cycle 1(1): loaded http://localhost:40327/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40327/tests/kraken/driver.html?testName=audio-dft) 01:46:29 INFO - PROCESS | 13239 | RSS: Main: 174944256 01:46:29 INFO - PROCESS | 13239 | 01:46:31 INFO - PROCESS | 13239 | Cycle 1(1): loaded http://localhost:40327/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40327/tests/kraken/driver.html?testName=audio-fft) 01:46:32 INFO - PROCESS | 13239 | RSS: Main: 266625024 01:46:32 INFO - PROCESS | 13239 | 01:46:34 INFO - PROCESS | 13239 | Cycle 1(1): loaded http://localhost:40327/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40327/tests/kraken/driver.html?testName=audio-oscillator) 01:46:35 INFO - PROCESS | 13239 | RSS: Main: 173699072 01:46:35 INFO - PROCESS | 13239 | 01:46:37 INFO - PROCESS | 13239 | Cycle 1(1): loaded http://localhost:40327/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40327/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:46:37 INFO - PROCESS | 13239 | RSS: Main: 174977024 01:46:37 INFO - PROCESS | 13239 | 01:46:40 INFO - PROCESS | 13239 | Cycle 1(1): loaded http://localhost:40327/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40327/tests/kraken/driver.html?testName=imaging-darkroom) 01:46:41 INFO - PROCESS | 13239 | RSS: Main: 214159360 01:46:41 INFO - PROCESS | 13239 | 01:46:44 INFO - PROCESS | 13239 | Cycle 1(1): loaded http://localhost:40327/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40327/tests/kraken/driver.html?testName=imaging-desaturate) 01:46:45 INFO - PROCESS | 13239 | RSS: Main: 212402176 01:46:45 INFO - PROCESS | 13239 | 01:46:47 INFO - PROCESS | 13239 | Cycle 1(1): loaded http://localhost:40327/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40327/tests/kraken/driver.html?testName=json-parse-financial) 01:46:48 INFO - PROCESS | 13239 | RSS: Main: 211296256 01:46:48 INFO - PROCESS | 13239 | 01:46:49 INFO - PROCESS | 13239 | Cycle 1(1): loaded http://localhost:40327/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40327/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:46:50 INFO - PROCESS | 13239 | RSS: Main: 173174784 01:46:50 INFO - PROCESS | 13239 | 01:46:52 INFO - PROCESS | 13239 | Cycle 1(1): loaded http://localhost:40327/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40327/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:46:52 INFO - PROCESS | 13239 | RSS: Main: 179974144 01:46:52 INFO - PROCESS | 13239 | 01:46:54 INFO - PROCESS | 13239 | Cycle 1(1): loaded http://localhost:40327/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40327/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:46:55 INFO - PROCESS | 13239 | RSS: Main: 189792256 01:46:55 INFO - PROCESS | 13239 | 01:46:57 INFO - PROCESS | 13239 | Cycle 1(1): loaded http://localhost:40327/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40327/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:46:58 INFO - PROCESS | 13239 | RSS: Main: 194183168 01:46:58 INFO - PROCESS | 13239 | 01:47:01 INFO - PROCESS | 13239 | Cycle 1(1): loaded http://localhost:40327/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40327/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:47:01 INFO - PROCESS | 13239 | RSS: Main: 195215360 01:47:01 INFO - PROCESS | 13239 | 01:47:03 INFO - PROCESS | 13239 | Cycle 1(1): loaded http://localhost:40327/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40327/tests/kraken/driver.html?testName=ai-astar) 01:47:03 INFO - PROCESS | 13239 | RSS: Main: 246792192 01:47:03 INFO - PROCESS | 13239 | 01:47:03 INFO - PROCESS | 13239 | __start_tp_report 01:47:03 INFO - PROCESS | 13239 | _x_x_mozilla_page_load 01:47:03 INFO - PROCESS | 13239 | _x_x_mozilla_page_load_details 01:47:03 INFO - PROCESS | 13239 | |i|pagename|runs| 01:47:03 INFO - PROCESS | 13239 | |0;ai-astar;103;110;110;110;110;111;111;110;111;110 01:47:03 INFO - PROCESS | 13239 | |1;audio-beat-detection;146;118;116;164;121;123;120;115;146;123 01:47:03 INFO - PROCESS | 13239 | |2;audio-dft;161;160;160;161;161;160;161;161;161;160 01:47:03 INFO - PROCESS | 13239 | |3;audio-fft;75;75;76;112;75;76;75;75;103;76 01:47:03 INFO - PROCESS | 13239 | |4;audio-oscillator;82;82;117;81;82;82;99;82;82;107 01:47:03 INFO - PROCESS | 13239 | |5;imaging-gaussian-blur;117;116;117;116;117;116;116;117;116;117 01:47:03 INFO - PROCESS | 13239 | |6;imaging-darkroom;146;147;146;146;146;147;146;145;146;146 01:47:03 INFO - PROCESS | 13239 | |7;imaging-desaturate;86;85;85;86;85;84;85;85;85;84 01:47:03 INFO - PROCESS | 13239 | |8;json-parse-financial;50;49;49;52;50;50;51;50;50;49 01:47:03 INFO - PROCESS | 13239 | |9;json-stringify-tinderbox;59;60;59;59;60;59;59;59;59;60 01:47:03 INFO - PROCESS | 13239 | |10;stanford-crypto-aes;78;79;74;74;75;77;74;82;74;75 01:47:03 INFO - PROCESS | 13239 | |11;stanford-crypto-ccm;130;123;125;119;129;120;120;127;193;121 01:47:03 INFO - PROCESS | 13239 | |12;stanford-crypto-pbkdf2;155;152;152;153;152;156;152;158;153;151 01:47:03 INFO - PROCESS | 13239 | |13;stanford-crypto-sha256-iterative;62;65;62;63;62;61;61;61;65;60 01:47:03 INFO - PROCESS | 13239 | __end_tp_report 01:47:03 INFO - PROCESS | 13239 | __start_cc_report 01:47:03 INFO - PROCESS | 13239 | _x_x_mozilla_cycle_collect,1633 01:47:03 INFO - PROCESS | 13239 | __end_cc_report 01:47:03 INFO - PROCESS | 13239 | __startTimestamp1484041623810__endTimestamp 01:47:03 INFO - PROCESS | 13239 | 01:47:03 INFO - PROCESS | 13239 | ------- Summary: start ------- 01:47:03 INFO - PROCESS | 13239 | Number of tests: 14 01:47:03 INFO - PROCESS | 13239 | 01:47:03 INFO - PROCESS | 13239 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:2.37 (2.2%) stddev-sans-first:0.50 01:47:03 INFO - PROCESS | 13239 | Values: 103.0 110.0 110.0 110.0 110.0 111.0 111.0 110.0 111.0 110.0 01:47:03 INFO - PROCESS | 13239 | 01:47:03 INFO - PROCESS | 13239 | [#1] audio-beat-detection Cycles:10 Average:129.20 Median:123.00 stddev:16.69 (13.6%) stddev-sans-first:16.55 01:47:03 INFO - PROCESS | 13239 | Values: 146.0 118.0 116.0 164.0 121.0 123.0 120.0 115.0 146.0 123.0 01:47:03 INFO - PROCESS | 13239 | 01:47:03 INFO - PROCESS | 13239 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 01:47:03 INFO - PROCESS | 13239 | Values: 161.0 160.0 160.0 161.0 161.0 160.0 161.0 161.0 161.0 160.0 01:47:03 INFO - PROCESS | 13239 | 01:47:03 INFO - PROCESS | 13239 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.00 stddev:13.72 (18.3%) stddev-sans-first:14.33 01:47:03 INFO - PROCESS | 13239 | Values: 75.0 75.0 76.0 112.0 75.0 76.0 75.0 75.0 103.0 76.0 01:47:03 INFO - PROCESS | 13239 | 01:47:03 INFO - PROCESS | 13239 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:82.00 stddev:13.18 (16.1%) stddev-sans-first:13.68 01:47:03 INFO - PROCESS | 13239 | Values: 82.0 82.0 117.0 81.0 82.0 82.0 99.0 82.0 82.0 107.0 01:47:03 INFO - PROCESS | 13239 | 01:47:03 INFO - PROCESS | 13239 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 01:47:03 INFO - PROCESS | 13239 | Values: 117.0 116.0 117.0 116.0 117.0 116.0 116.0 117.0 116.0 117.0 01:47:03 INFO - PROCESS | 13239 | 01:47:03 INFO - PROCESS | 13239 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 01:47:03 INFO - PROCESS | 13239 | Values: 146.0 147.0 146.0 146.0 146.0 147.0 146.0 145.0 146.0 146.0 01:47:03 INFO - PROCESS | 13239 | 01:47:03 INFO - PROCESS | 13239 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.67 (0.8%) stddev-sans-first:0.60 01:47:03 INFO - PROCESS | 13239 | Values: 86.0 85.0 85.0 86.0 85.0 84.0 85.0 85.0 85.0 84.0 01:47:03 INFO - PROCESS | 13239 | 01:47:03 INFO - PROCESS | 13239 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:50.00 stddev:0.94 (1.9%) stddev-sans-first:1.00 01:47:03 INFO - PROCESS | 13239 | Values: 50.0 49.0 49.0 52.0 50.0 50.0 51.0 50.0 50.0 49.0 01:47:03 INFO - PROCESS | 13239 | 01:47:03 INFO - PROCESS | 13239 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 01:47:03 INFO - PROCESS | 13239 | Values: 59.0 60.0 59.0 59.0 60.0 59.0 59.0 59.0 59.0 60.0 01:47:03 INFO - PROCESS | 13239 | 01:47:03 INFO - PROCESS | 13239 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.00 stddev:2.74 (3.6%) stddev-sans-first:2.83 01:47:03 INFO - PROCESS | 13239 | Values: 78.0 79.0 74.0 74.0 75.0 77.0 74.0 82.0 74.0 75.0 01:47:03 INFO - PROCESS | 13239 | 01:47:03 INFO - PROCESS | 13239 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:126.00 stddev:22.24 (17.6%) stddev-sans-first:23.58 01:47:03 INFO - PROCESS | 13239 | Values: 130.0 123.0 125.0 119.0 129.0 120.0 120.0 127.0 193.0 121.0 01:47:03 INFO - PROCESS | 13239 | 01:47:03 INFO - PROCESS | 13239 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:153.00 stddev:2.22 (1.5%) stddev-sans-first:2.28 01:47:03 INFO - PROCESS | 13239 | Values: 155.0 152.0 152.0 153.0 152.0 156.0 152.0 158.0 153.0 151.0 01:47:03 INFO - PROCESS | 13239 | 01:47:03 INFO - PROCESS | 13239 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.00 stddev:1.69 (2.7%) stddev-sans-first:1.79 01:47:03 INFO - PROCESS | 13239 | Values: 62.0 65.0 62.0 63.0 62.0 61.0 61.0 61.0 65.0 60.0 01:47:03 INFO - PROCESS | 13239 | -------- Summary: end -------- 01:47:03 INFO - PROCESS | 13239 | 01:47:04 INFO - TEST-INFO | 13239: exit 0 01:47:04 INFO - TEST-OK | kraken | took 59177ms 01:47:04 INFO - SUITE-END | took 1174s 01:47:04 INFO - Completed test suite (00:19:34) 01:47:04 INFO - javascript benchmark 01:47:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3148.7481001519873, 3165.208697825543, 3194.728448081913, 3214.1482507135597, 3231.3537292541496, 5442.619016668835, 5499.890002199953, 5536.363318218406, 5569.053260945639, 5569.220309156722, 5519.806806761764, 5527.806526771554, 5539.501444869961, 5542.612017158801, 5556.027695153352, 4983.277424773406, 5002.224655178453, 5023.422306434752, 5027.648064635477, 5075.593952483792, 5002.349694539705, 5018.548330650241, 5067.74661266937, 5100.132977393833, 5104.285400043997, 5035.043341765071, 5041.873953151164, 5056.494350564951, 5080.034793389263, 5082.161443361841, 5042.268871013701, 5094.108531007059, 5162.535371816554, 5177.870553236162, 5196.168613021936, 4897.118518666639, 4908.852734417937, 5053.620978426633, 5076.670016448956, 5127.564157046656, 5422.186671999192, 5430.402655707869, 5443.537299329561, 5463.508284254396, 5465.371482279549, 5850.3564607893095, 5898.675572843492, 5950.077737950624, 5957.434043765836, 5963.165156878041, 5818.0981947798155, 5891.204687367193, 5957.285125784933, 5980.252468441445, 5986.700664966735, 5510.614257002011, 5531.944680553223, 5548.833534993957, 5550.222968784374, 5572.359178694421, 6073.18012068374, 6081.239845019372, 6094.238220222473, 6098.939010609837, 6106.877862442815, 5687.971560142256, 5755.366909639936, 5860.531157507389, 5870.3249126350165, 5875.941240587625, 5895.67573783446, 5897.085951677497, 5906.49794767441, 5985.910211346833, 6017.849553761191, 5941.31674857397, 5951.226340575698, 5955.76176952917, 5959.523238140939, 5997.250343707036, 5760.308762948473, 5904.291485021739, 5950.315713692894, 5962.165296858443, 5962.284525856925, 4514.548545145525, 4524.547545245515, 4544.045750392388, 4559.863204103882, 4564.0871825635, 4091.4681091458515, 4094.6314831665295, 4108.876733697994, 4117.814698338582, 4123.814428350732, 5589.664620122806, 5596.608237423341, 5605.1031834907035, 5605.271314729059, 5610.13042978339, 5751.712414379264, 5825.563082768809, 5900.291964964146, 5960.523158147338, 5986.431289027535, 5576.219329293902, 5577.414371491016, 5653.095504719226, 5658.830235092953, 5665.575081868877, 5125.2568377585785, 5127.07712611726, 5131.87170320745, 5142.820001299937, 5152.6908385496245, 6015.6691381974415, 6067.029275315928, 6196.47329976948, 6266.968665156645, 6273.466755325849, 5947.31605865331, 5975.940240597713, 5996.580239383201, 6060.818175454743, 6061.454469097803, 6254.8123556293385, 6277.937220627735, 6288.654124023223, 6292.52806039558, 6292.559520833498, 5716.28546431696, 5914.467697907209, 5923.378045305181, 5923.703814809329, 5954.225950626391, 5780.797672081457, 5937.139114828412, 5954.791582294599, 5993.220881285405, 6075.3317135115985, 5863.384344643921, 5890.941090589211, 5893.675847828411, 5893.941060589511, 5899.085641725539, 5874.030784920611, 5880.235569375954, 5887.676177810262, 5888.0, 5888.087346461305, 5634.352049514195, 5680.829575112753, 5683.232763576864, 5691.630044047124, 5781.739821707949, 5870.706464676835, 5873.735681894411, 5877.382874798255, 5884.176215329943, 5902.085176797603, 5578.0, 5599.8880022400135, 5715.971420142872, 5724.055530837365, 5725.656460612377], "value": 5480.934232054608, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.1178673056761, 630.9747610095596, 634.80955713286, 654.5777973207281, 659.8584448903395, 33915.830420847895, 44165.33751993719, 44713.0, 44817.32774008392, 45008.54991450084, 45285.32072018922, 45563.0, 45665.77167114168, 45769.771151144196, 45790.08419831601, 8229.177082291782, 8423.36824738144, 8818.51498167599, 8953.970293416276, 8966.506842123681, 10391.220658450646, 10738.624148154817, 10749.140068794517, 10997.285176463543, 11010.669679909615, 10842.13262938967, 10908.836367454494, 10909.618163364285, 10915.508802103885, 10916.0, 10720.463976801168, 10770.515326810313, 10776.946115269373, 10777.353358798497, 10786.5685372585, 10711.94644026775, 10780.245382823205, 10780.353178809297, 10781.4609269537, 10782.67651970442, 43097.35353969693, 43326.0, 43383.783081084395, 43458.34812477815, 43467.565324346986, 3442.7245820334315, 3485.093875592339, 3519.208178159919, 3598.6941110005682, 4273.722208056466, 31514.52728209056, 32073.198170045936, 32173.83913080443, 32405.0, 32485.187870303194, 4195.895102622429, 4489.393931819195, 4506.864794056183, 4554.749488778116, 4630.143423466636, 362903.0, 363185.0, 363220.0, 363322.0, 363336.9999999974, 59603.701981489816, 59795.402045979856, 59957.70021149866, 59971.700141499015, 59982.40017599768, 38780.224395511934, 39772.60227397747, 39957.40063899044, 41747.165056698694, 41800.37299440511, 18349.266029358678, 18619.813801862078, 18634.72047919255, 18647.160877760532, 18662.78691885023, 10386.896131038744, 10474.214433917487, 14041.508547201003, 14371.20958347301, 14425.134491930517, 19946.0, 20021.399358019284, 20098.89950550238, 20155.0930208141, 20190.899045504677, 7172.641367931583, 7193.5324203926575, 7238.348548630648, 7257.983882256488, 7317.597532135784, 985.7781999050156, 1026.343140390151, 1065.4246706778408, 1081.3565928272665, 1120.4733775125678, 32586.348273034408, 33160.66839331624, 33199.3360132796, 33267.0, 33759.83120084384, 1073.3774410841693, 1130.6099395708468, 1131.0725205331548, 1142.0863309352485, 1179.4397661111075, 16454.917725411535, 17181.31274749021, 17437.7384339235, 17824.46526604204, 18218.17418342163, 537543.0, 541265.0, 543621.0, 544274.0, 546973.0, 58276.70861645665, 59178.11232831511, 59180.0, 59261.70369148213, 59273.40726592679, 1301.7656821771982, 1329.8803107720157, 1358.8301462317409, 1405.1709491400122, 1444.4005737618982, 29764.85117574398, 34278.82860585681, 34558.06565654023, 34563.30873382569, 34829.477557836144, 49381.25928111153, 50148.0, 50190.0, 50190.247146293565, 50240.74879625725, 395896.0, 396755.0, 398325.0, 399495.0, 400718.0, 29226.853865730536, 29625.407491850474, 29823.70176298209, 30175.547366789076, 31186.532202016533, 46717.53282467268, 46911.29633055439, 47294.0, 48044.51955480401, 48075.438238179675, 41451.58548414477, 41563.7921810389, 41633.37549936693, 41753.79123104365, 43163.56836431596, 40206.0, 40784.1843163141, 41337.40719361457, 41970.160596788504, 42344.788276059655, 41671.58328416677, 42182.36726449044, 42186.57813421827, 42607.57392426036, 42760.572394276904, 34878.82560587181, 36976.0, 37040.444393333586, 37311.253774924895, 37650.0, 28483.572746409234, 28533.571996420487, 28783.280417989718, 28928.710712893444, 29006.56490152607], "value": 20665.894722976755, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.79610398696656, 418.6106920563876, 425.9510156332023, 429.1267271103304, 442.687905026956, 15109.622259443506, 18929.24283028679, 19064.523386915334, 19478.1234844432, 19759.5060123497, 19489.12298946547, 19547.60904781907, 19994.300199492984, 20094.39716808498, 20494.795052049474, 5485.204645326436, 5702.0, 5708.65748055118, 5709.914351284734, 5720.22776925114, 5526.447355264481, 5543.168524721304, 5621.7189140542805, 5636.859078523049, 5648.237487939137, 5607.214989901417, 5616.157576363557, 5618.550515958734, 5621.0444224481735, 5622.297212848394, 5405.135178371462, 5516.558675305966, 5532.197831314437, 5538.418466061086, 5543.168524721284, 4996.531572669806, 5035.320231768701, 5039.521245481674, 5042.142835717937, 5045.949540504585, 23800.285991420285, 24035.158769442987, 24075.51848963011, 24362.878185609137, 24791.876040619863, 2421.237310247284, 2439.3657649011207, 2490.9750902490923, 2505.0981646607206, 2535.7681754122214, 14856.405743770236, 14992.100473971597, 15101.5469535913, 15171.393144274216, 15379.692406151815, 1906.4757191772235, 1948.9902550487157, 1994.2322205950813, 2002.3992802159294, 2033.9694904576443, 87325.99999999936, 87630.0, 88619.55690221507, 88916.55541722315, 89171.55414222888, 9402.15380615748, 10735.57057717698, 11345.432728363548, 12503.687112853202, 12584.622461326175, 13975.720485590231, 14777.335019924129, 14784.0, 14809.259537023107, 14825.555233343017, 7386.002889609941, 7885.29032387088, 8608.182222688834, 8699.565021749015, 8887.866681999774, 8552.786180345542, 8814.294856411472, 8870.895899116042, 8979.685711000084, 9152.633894644272, 6650.733970641217, 6865.450763938873, 6944.881811047578, 6993.825154371079, 7024.824379390556, 1749.7375393690793, 1753.9473815785548, 1809.5018472815725, 1819.5724004858848, 1840.6379279333464, 942.6794889737522, 996.8056229035268, 1061.9150467962545, 1062.7768168684509, 1078.7357097511003, 19853.900730496545, 20302.39092827188, 20430.69353959692, 20462.488437789176, 20618.0, 1049.150188347441, 1073.1468482556231, 1079.5142186016324, 1083.5394957143183, 1099.4008265495324, 10844.566217351376, 11755.941220294015, 11758.294502329887, 11874.643760687193, 11962.282263064244, 494314.0, 496675.83426829, 505486.0, 505647.0, 508503.0, 50274.748626257366, 50906.0, 54951.0, 80750.0, 85107.57446212853, 1005.4106838586323, 1029.1920842138884, 1034.379372376583, 1046.7435478307864, 1048.067220174061, 17688.55778605494, 18024.819751802315, 18325.0, 18388.632227355647, 18786.906065469586, 28666.71333286724, 36364.0, 39109.608903911736, 41059.0, 41672.16655666809, 47043.0, 47339.52660473489, 54973.17540236819, 58141.0, 58346.0, 8503.447275927292, 8556.27271681914, 8684.26183774361, 8816.735497935073, 8906.599203036008, 9726.610935562498, 12851.871481285441, 13047.673808154872, 13178.341082946006, 13635.0, 11293.887061129284, 11343.943280283545, 11430.25703329281, 11502.539898404304, 12178.634640960785, 11775.823362649739, 11941.16411851162, 12086.335251560897, 12341.938290308492, 12444.0, 11134.3876086816, 11784.292942423483, 12192.329421881881, 12230.816537752118, 12454.937725311316, 7753.651085701044, 8114.310283625958, 8877.73366798997, 8981.191692747683, 9185.0, 11495.942520287344, 11690.0, 11785.646430607096, 11887.643370698894, 12046.0], "value": 9399.355344986026, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.716979434319, 1393.6933874547599, 1473.2044695864233, 1719.4411816159752, 1721.3975108711952, 7885.0932142803595, 8411.242988131067, 8417.326613870891, 8420.284275836546, 8420.410571260014, 7537.510061845976, 7717.961410192941, 7949.205079492062, 8091.757247282576, 8234.588270586462, 2385.487120269142, 2411.2163546847255, 2414.0, 2418.383312255381, 2418.830681852271, 2425.4300239443714, 2432.927012189637, 2461.1386014894824, 2470.209532949457, 2472.3571871313497, 2364.798992085675, 2371.5612611666897, 2379.512199998996, 2386.3556839653284, 2389.4026493376655, 2331.475418030938, 2356.905723771056, 2359.5162991586685, 2363.3737059679197, 2403.495265994143, 2322.047960336271, 2361.8228632852433, 2376.0733314007553, 2378.036895057487, 2381.4641705616273, 8349.54077525736, 8370.83258334836, 8427.747167584983, 8431.156884311582, 8439.873401898914, 5050.368703912011, 5196.168613021899, 5200.739963001873, 5207.244949482341, 5209.218617207449, 3226.1128189747774, 3338.4992251162275, 3375.0, 3444.225049363898, 3453.861845526176, 1182.5860948667898, 1201.549418967887, 1215.5867005218179, 1218.719694470268, 1242.6582689760298, 11594.072474202128, 11724.0, 11765.352905590104, 11771.7057073573, 11775.470103845348, 4223.957760422418, 4484.529124441952, 4543.863684089482, 4647.442306923191, 4657.0, 9372.390794598467, 9401.858972115424, 9458.57436415363, 9465.290103242147, 9473.336866419422, 5140.126178549655, 5164.9741751291, 5210.817621383233, 5215.817446389358, 5222.634415590872, 4402.757848318373, 4462.598366146997, 4465.508794032654, 4859.173940430064, 4885.560299573055, 3862.517185351831, 3893.844246230176, 3942.9211415772097, 3979.3235150024566, 3984.083660758042, 1220.414201183437, 1224.6264889208876, 1225.2403509823966, 1232.1128787273149, 1255.460152134591, 847.7626264645909, 851.8849955255961, 945.9101385368378, 948.7248697877538, 986.2504496582649, 5610.607257492018, 5676.0918253080135, 5724.570657200727, 5744.281964754406, 5939.851503712442, 459.9172149013143, 468.6250999200626, 469.25154378765814, 472.32929240478603, 474.3761953031752, 3728.683061939711, 3754.305453491113, 3763.247350529905, 3788.6211378862445, 3807.961920380816, 9991.0, 10260.230482713827, 10447.216458765623, 10457.372557646566, 10458.477076146162, 10225.744356391, 10322.638707645196, 10362.585496580203, 10374.844377334346, 10381.273310868317, 7970.1631328709655, 8123.431359804875, 8124.390670699603, 8132.146124656944, 8133.674653013813, 5450.400455949922, 5456.399796022355, 5526.972365138148, 5538.584606154474, 5542.196381524737, 9407.717768466957, 9430.481323527272, 9507.857382139135, 9545.28410369239, 9724.659636912957, 9615.711528654152, 9656.37233579815, 9737.22102231834, 9763.316567840184, 9850.605975761177, 6629.933700662931, 6736.93263067363, 7045.471589630901, 7257.0565826442225, 7355.1541572719825, 8363.874541881754, 8389.580520974048, 8397.454165479225, 8400.537970411442, 8419.073901870912, 7241.782746517613, 7245.130584329703, 7321.450891183076, 7495.213002634645, 7504.437167212372, 7193.5324203926575, 7320.048393708784, 7387.8153046174275, 7525.623718814147, 7547.584882831277, 6789.490788190807, 6924.58452492852, 6928.0, 6937.959306104125, 6940.063091482585, 5105.642605017613, 5156.04613146569, 5174.068667639711, 5189.247559103985, 5297.231901374202, 5115.462876398074, 5262.789488420421, 5267.394249661184, 5270.0, 5315.601329900351], "value": 4438.7786750542, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.56928838951313, 358.90489020409586, 360.7636997766463, 362.7823306016389, 363.2263279215271, 5363.0, 5487.79268560917, 5518.116466926768, 5522.0888553388695, 5523.7238138093135, 5390.6226564140525, 5392.379876314225, 5407.161889907071, 5412.539934105596, 5417.83746487605, 4017.629598536863, 4093.5497095319492, 4321.9783901080455, 4326.52898014675, 4340.3489476578525, 4291.339369590843, 4305.935410968838, 4312.849050283241, 4315.136972605475, 4333.2200203963275, 4264.7441153530735, 4272.807723652443, 4278.7218830776055, 4280.486341639008, 4283.443152390185, 4219.282721937278, 4286.87139385819, 4301.956980430187, 4321.416608757809, 4329.631981281595, 3807.97184760116, 3818.618138186187, 3821.0, 3859.671927886133, 3877.457155998134, 5277.3139491866195, 5291.259223708684, 5298.417174110845, 5311.28297679816, 5313.548348390392, 4727.66906316558, 4877.34155888954, 4913.06651736169, 4913.091078150554, 4930.852074437773, 5591.217229587861, 5623.662580245198, 5628.183913332544, 5652.880169936274, 5663.886722265573, 4187.685923555746, 4195.580441955811, 4196.664266858644, 4200.831966721327, 4202.2646036943415, 5727.0, 5868.471837534642, 5875.794347197828, 5898.793542226044, 5916.615419997729, 4268.701190916606, 4288.52826189119, 4295.72077814941, 4308.9353659695125, 4321.783910804447, 4343.283358245917, 4354.303311470149, 4369.956300437018, 4382.474103107584, 4394.846180383671, 4758.476567577563, 4903.901921961612, 4942.332785073969, 4961.181405068195, 4968.478309777493, 5645.5201307888465, 5647.491725744702, 5673.659580425187, 5685.635447492572, 5699.544036477072, 1428.6285565752978, 1451.7677171652485, 1453.5464535464534, 1456.9053011554215, 1466.7726502392147, 990.3562684255147, 1026.3995562595817, 1040.947952602382, 1041.463646222196, 1050.2858056521638, 5301.68189908599, 5314.7608357624, 5379.65032272901, 5438.510534051875, 5560.888782224333, 5849.853753656193, 5851.795187168429, 5859.275436921852, 5867.911981320283, 5882.264716910387, 5304.946950530445, 5502.752376143083, 5551.250581171571, 5558.416366281563, 5568.805091821848, 2977.568252603404, 3008.3832814273023, 3020.214744166489, 3027.061610900628, 3034.770917778259, 5895.882082358329, 5902.911456328158, 5920.5559583031445, 5958.106284057426, 5994.910076348859, 5546.972265138648, 5748.655080695088, 5768.3654797972185, 5800.6356313338165, 5812.534997200214, 5775.393583673737, 5818.42167067259, 5841.474267315962, 5873.471387575139, 5876.412358764175, 5607.775688972395, 5700.714964251853, 5701.116326969326, 5780.479756821906, 5781.797637082682, 5798.797042103506, 5799.101139323411, 5805.390434004369, 5813.3605303417435, 5821.970890145522, 6074.969625151846, 6079.1793107931635, 6103.199556130863, 6181.289151747606, 6191.19514463117, 4215.515215750228, 4268.207352911722, 4275.914481710286, 4279.144171165717, 4310.288802347577, 5802.129680547782, 5813.186153938367, 5834.986929509312, 5866.5893387464175, 5867.471927526543, 5662.8301150965535, 5709.23013865703, 5776.191333213437, 5795.1017592273265, 5812.447817457335, 5703.34602965152, 5707.315122185364, 5720.399358067343, 5723.914141287801, 5738.569607279387, 5664.688442135557, 5676.864627074684, 5678.5803549112725, 5680.9147862781265, 5693.829185124453, 5328.021169369954, 5562.471565201299, 5723.856903577277, 5760.235087158271, 5820.447057529528, 5578.82844602638, 5583.274174357308, 5586.413426590312, 5606.215129881902, 5611.018071837494], "value": 4374.350704049644, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.5810067311969, 746.216472703661, 747.3572727454389, 811.5942028985507, 867.5662168915542, 13837.238951857644, 14457.204853733041, 14503.782443263346, 14517.49188778393, 14532.200728959902, 14586.635334116625, 14887.478938237136, 14889.106653600791, 14895.73386262169, 14902.999999999973, 708.6810935079209, 721.8664547058811, 839.9244068033876, 853.6628031927385, 865.0614083719172, 832.2426591801462, 839.0602525171817, 839.9412041157121, 840.0759164918602, 840.5629072882098, 887.024273299372, 888.5424006636588, 888.6534251641832, 889.0087552379115, 889.5641135843423, 723.9891401628953, 734.9706011759523, 879.4327658660193, 887.0774394629577, 889.4885440871492, 635.8346829824279, 672.6905623413187, 672.9831754206184, 673.7406098652054, 673.8854394752904, 15104.244787760677, 15193.772093418607, 15206.08763474195, 15208.315625796866, 15211.315490802941, 14327.498537551135, 14339.42642294307, 14502.05736627116, 14567.417303307855, 14608.415663373453, 12670.366481675972, 12716.364181790874, 12728.299943503103, 13079.476820927151, 13185.934070329682, 4433.645308375354, 4447.0661161156195, 4457.799399027019, 4462.598366147063, 4619.69971951822, 67300.6634966827, 67314.66342668304, 67316.99024514685, 67762.0, 68121.318786812, 10667.83998240027, 10780.838287425695, 10986.835197472044, 11001.504932278067, 11336.376499292619, 18518.81481185171, 19152.712709309373, 19197.136128874234, 21080.262190823247, 21157.471063223235, 8475.660973560989, 8552.657893684307, 8642.654293828176, 8662.2637075848, 9078.182963533314, 4738.549837765407, 4742.810287588527, 4788.257820037899, 4910.582600478928, 4924.655274130848, 3378.543896573931, 3475.565554305712, 3476.5480487536456, 3478.3912815257227, 3479.356319080978, 608.7412849538928, 621.3010363341241, 636.0268788753215, 640.6636515829134, 647.2588885725818, 753.8793792993094, 758.5208842756647, 778.5951305321202, 782.6986610155132, 808.6724876425058, 9743.123118919331, 9751.414915105117, 9846.409215446953, 9876.209903207726, 9887.357321774061, 679.9524033317621, 755.2749360613873, 763.2215140556601, 774.8062984253936, 794.6026986506747, 4673.112108699336, 4775.737334446639, 4853.466118726938, 4873.669487238026, 4882.829100981448, 87184.0, 87845.56077219702, 88640.0, 90182.09817901737, 93294.0, 59359.0, 64806.351936480976, 65151.348486515475, 66172.0, 78610.6069469649, 60702.0, 61063.0, 61665.38334616686, 63112.0, 63676.36323636797, 9662.3719458235, 9835.950820245853, 10111.696649100539, 10128.34165779222, 10168.33905796121, 37082.25835483329, 42946.0, 43835.561644383146, 43879.34180987351, 44547.331790023825, 57594.0, 61077.0, 61297.693511533944, 61512.0, 63647.0, 11421.942890285496, 12177.086718495972, 12290.324032178316, 12399.504019839105, 12501.999840012595, 13475.932620336836, 13596.524121655695, 13795.172289662652, 13915.0, 13939.372728227458, 13256.204627721982, 13550.457981681016, 13554.254516001714, 13622.727545449234, 14064.156150630995, 12927.806082908952, 13074.150180238254, 13289.601311960656, 13367.0, 13603.795943060664, 12417.192882462972, 13272.27002514871, 13483.865161348262, 13525.59423217305, 13556.525521606696, 11015.614453494089, 11093.889061109285, 11147.537706523906, 11208.439578021229, 11706.1220408468, 10940.56237750481, 11159.832602511131, 11265.324080555192, 11466.82799758021, 11696.532138714696], "value": 7308.597106412298, "unit": "score"}], "name": "dromaeo_css", "value": 7298.114193800546, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 111.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 116.0, 164.0, 121.0, 123.0, 120.0, 115.0, 146.0, 123.0], "value": 129.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 112.0, 75.0, 76.0, 75.0, 75.0, 103.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 117.0, 81.0, 82.0, 82.0, 99.0, 82.0, 82.0, 107.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 86.0, 85.0, 84.0, 85.0, 85.0, 85.0, 84.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 52.0, 50.0, 50.0, 51.0, 50.0, 50.0, 49.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 60.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 74.0, 74.0, 75.0, 77.0, 74.0, 82.0, 74.0, 75.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 123.0, 125.0, 119.0, 129.0, 120.0, 120.0, 127.0, 193.0, 121.0], "value": 130.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 152.0, 152.0, 153.0, 152.0, 156.0, 152.0, 158.0, 153.0, 151.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 62.0, 63.0, 62.0, 61.0, 61.0, 61.0, 65.0, 60.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1450.2000000000003, "alertThreshold": 2.0}]} 01:47:05 INFO - Return code: 0 01:47:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:47:05 INFO - # TBPL SUCCESS # 01:47:05 INFO - Running post-action listener: _resource_record_post_action 01:47:05 INFO - [mozharness: 2017-01-10 09:47:05.116358Z] Finished run-tests step (success) 01:47:05 INFO - Running post-run listener: _resource_record_post_run 01:47:05 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 357322752; Read time: 8; Write time: 188972 01:47:05 INFO - TinderboxPrint: CPU usage
12.9% 01:47:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 01:47:05 INFO - TinderboxPrint: I/O write bytes / time
357,322,752 / 188,972 01:47:05 INFO - TinderboxPrint: CPU idle
8,266.3 (87.0%) 01:47:05 INFO - TinderboxPrint: CPU user
1,189.1 (12.5%) 01:47:05 INFO - TinderboxPrint: Swap in / out
0 / 0 01:47:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118665216; Read time: 0; Write time: 63736 01:47:05 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 238657536; Read time: 0; Write time: 125236 01:47:05 INFO - Running post-run listener: _upload_blobber_files 01:47:05 INFO - Blob upload gear active. 01:47:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:47:05 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 01:47:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:47:06 INFO - (blobuploader) - INFO - Open directory for files ... 01:47:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:47:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:47:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:47:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:47:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:47:06 INFO - (blobuploader) - INFO - Done attempting. 01:47:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:47:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:47:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:47:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:47:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:47:09 INFO - (blobuploader) - INFO - Done attempting. 01:47:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:47:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:47:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:47:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:47:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:47:10 INFO - (blobuploader) - INFO - Done attempting. 01:47:10 INFO - (blobuploader) - INFO - Iteration through files over. 01:47:10 INFO - Return code: 0 01:47:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:47:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:47:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/602b747d550e218f40ec493dee28b8f91761551a43c8372e2f9ac9af60897d19ac676571965c28f3e60b7a578fa6949863d460efec7fb3a706187d225ae9aa1f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5ad2a7f95db7046a349d5ddf4daec9ed07a49aa9d77d48dcdc3045b115b1a2ffb37ba0e92177086a8c3c9d3150734e25ee009e1726572a79769a247857c9534", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01bc7c8666f311444cbbd172c89629b0057a64670fc7868431828834e40595a50eded757a91a1ea830b3ea0facd5523c1eac2d7f6510c21a8a9060d3f4b9094e"} 01:47:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:47:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:47:10 INFO - Contents: 01:47:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/602b747d550e218f40ec493dee28b8f91761551a43c8372e2f9ac9af60897d19ac676571965c28f3e60b7a578fa6949863d460efec7fb3a706187d225ae9aa1f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5ad2a7f95db7046a349d5ddf4daec9ed07a49aa9d77d48dcdc3045b115b1a2ffb37ba0e92177086a8c3c9d3150734e25ee009e1726572a79769a247857c9534", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01bc7c8666f311444cbbd172c89629b0057a64670fc7868431828834e40595a50eded757a91a1ea830b3ea0facd5523c1eac2d7f6510c21a8a9060d3f4b9094e"} 01:47:10 INFO - Running post-run listener: copy_logs_to_upload_dir 01:47:10 INFO - Copying logs to upload dir... 01:47:10 INFO - mkdir: /builds/slave/test/build/upload/logs 01:47:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.255499 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-01-10 01:47:10.210890) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 01:47:10.214516) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/602b747d550e218f40ec493dee28b8f91761551a43c8372e2f9ac9af60897d19ac676571965c28f3e60b7a578fa6949863d460efec7fb3a706187d225ae9aa1f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5ad2a7f95db7046a349d5ddf4daec9ed07a49aa9d77d48dcdc3045b115b1a2ffb37ba0e92177086a8c3c9d3150734e25ee009e1726572a79769a247857c9534", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01bc7c8666f311444cbbd172c89629b0057a64670fc7868431828834e40595a50eded757a91a1ea830b3ea0facd5523c1eac2d7f6510c21a8a9060d3f4b9094e"} build_url:https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011512 build_url: 'https://queue.taskcluster.net/v1/task/FJttjPNuTvWxdJMkFQ8aFQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/602b747d550e218f40ec493dee28b8f91761551a43c8372e2f9ac9af60897d19ac676571965c28f3e60b7a578fa6949863d460efec7fb3a706187d225ae9aa1f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5ad2a7f95db7046a349d5ddf4daec9ed07a49aa9d77d48dcdc3045b115b1a2ffb37ba0e92177086a8c3c9d3150734e25ee009e1726572a79769a247857c9534", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01bc7c8666f311444cbbd172c89629b0057a64670fc7868431828834e40595a50eded757a91a1ea830b3ea0facd5523c1eac2d7f6510c21a8a9060d3f4b9094e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 01:47:10.240107) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 01:47:10.240495) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1484040293.16354-1468468936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 01:47:10.324930) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 01:47:10.325265) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 01:47:10.325586) ========= ========= Total master_lag: 0.17 =========