builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-052 starttime: 1479500535.15 results: success (0) buildid: 20161118110822 builduid: 01897f143ba34bb5b99cef3754bfe158 revision: 7366f433e57d9b6fa35b2f4a0a59d22ee10e4ff6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 12:22:15.153923) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 12:22:15.154382) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 12:22:15.154678) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 12:22:15.233045) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 12:22:15.233355) ========= 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=826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-18 12:22:15-- 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% 221M=0s 2016-11-18 12:22:15 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.226497 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 12:22:15.507338) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 12:22:15.507631) ========= 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=826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.094308 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 12:22:15.614035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 12:22:15.614391) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 7366f433e57d9b6fa35b2f4a0a59d22ee10e4ff6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 7366f433e57d9b6fa35b2f4a0a59d22ee10e4ff6 --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=826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-18 12:22:15,722 truncating revision to first 12 chars 2016-11-18 12:22:15,722 Setting DEBUG logging. 2016-11-18 12:22:15,722 attempt 1/10 2016-11-18 12:22:15,723 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/7366f433e57d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 12:22:16,021 unpacking tar archive at: graphics-7366f433e57d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.624715 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 12:22:16.256597) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 12:22:16.256997) ========= script_repo_revision: 7366f433e57d9b6fa35b2f4a0a59d22ee10e4ff6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 12:22:16.257546) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 12:22:16.257921) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 12:22:16.269343) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-11-18 12:22:16.269747) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:22:16 INFO - MultiFileLogger online at 20161118 12:22:16 in /builds/slave/test 12:22:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 12:22:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:22:16 INFO - {'append_to_log': False, 12:22:16 INFO - 'base_work_dir': '/builds/slave/test', 12:22:16 INFO - 'blob_upload_branch': 'Graphics', 12:22:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:22:16 INFO - 'branch': 'Graphics', 12:22:16 INFO - 'buildbot_json_path': 'buildprops.json', 12:22:16 INFO - 'config_files': ('talos/linux_config.py',), 12:22:16 INFO - 'default_actions': ('clobber', 12:22:16 INFO - 'read-buildbot-config', 12:22:16 INFO - 'download-and-extract', 12:22:16 INFO - 'populate-webroot', 12:22:16 INFO - 'create-virtualenv', 12:22:16 INFO - 'install', 12:22:16 INFO - 'run-tests'), 12:22:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:22:16 INFO - 'download_minidump_stackwalk': True, 12:22:16 INFO - 'download_symbols': 'ondemand', 12:22:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:22:16 INFO - 'tooltool.py': '/tools/tooltool.py', 12:22:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:22:16 INFO - '/tools/misc-python/virtualenv.py')}, 12:22:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:22:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:22:16 INFO - 'installer_path': 'installer.exe', 12:22:16 INFO - 'log_level': 'info', 12:22:16 INFO - 'log_name': 'talos', 12:22:16 INFO - 'log_to_console': True, 12:22:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:22:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:22:16 INFO - 'opt_config_files': (), 12:22:16 INFO - 'pip_index': False, 12:22:16 INFO - 'sps_profile': False, 12:22:16 INFO - 'sps_profile_interval': 0, 12:22:16 INFO - 'suite': 'dromaeojs-e10s', 12:22:16 INFO - 'system_bits': '32', 12:22:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:22:16 INFO - 'title': 'talos-linux64-ix-052', 12:22:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:22:16 INFO - 'use_talos_json': True, 12:22:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:22:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:22:16 INFO - 'work_dir': 'build'} 12:22:16 INFO - [mozharness: 2016-11-18 20:22:16.573777Z] Running clobber step. 12:22:16 INFO - Running pre-action listener: _resource_record_pre_action 12:22:16 INFO - Running main action method: clobber 12:22:16 INFO - rmtree: /builds/slave/test/build 12:22:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:22:17 INFO - Running post-action listener: _resource_record_post_action 12:22:17 INFO - [mozharness: 2016-11-18 20:22:17.610315Z] Finished clobber step (success) 12:22:17 INFO - [mozharness: 2016-11-18 20:22:17.610547Z] Running read-buildbot-config step. 12:22:17 INFO - Running pre-action listener: _resource_record_pre_action 12:22:17 INFO - Running main action method: read_buildbot_config 12:22:17 INFO - Using buildbot properties: 12:22:17 INFO - { 12:22:17 INFO - "project": "", 12:22:17 INFO - "product": "firefox", 12:22:17 INFO - "script_repo_revision": "default", 12:22:17 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 12:22:17 INFO - "repository": "", 12:22:17 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 12:22:17 INFO - "buildid": "20161118110822", 12:22:17 INFO - "pgo_build": "False", 12:22:17 INFO - "basedir": "/builds/slave/test", 12:22:17 INFO - "buildnumber": 9, 12:22:17 INFO - "slavename": "talos-linux64-ix-052", 12:22:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:22:17 INFO - "platform": "ubuntu64_hw", 12:22:17 INFO - "scheduler": "tests-graphics-linux64-talos", 12:22:17 INFO - "branch": "graphics", 12:22:17 INFO - "repo_path": "projects/graphics", 12:22:17 INFO - "revision": "7366f433e57d9b6fa35b2f4a0a59d22ee10e4ff6", 12:22:17 INFO - "stage_platform": "linux64", 12:22:17 INFO - "builduid": "01897f143ba34bb5b99cef3754bfe158", 12:22:17 INFO - "slavebuilddir": "test" 12:22:17 INFO - } 12:22:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 12:22:17 INFO - Running post-action listener: _resource_record_post_action 12:22:17 INFO - [mozharness: 2016-11-18 20:22:17.616418Z] Finished read-buildbot-config step (success) 12:22:17 INFO - [mozharness: 2016-11-18 20:22:17.616629Z] Running download-and-extract step. 12:22:17 INFO - Running pre-action listener: _resource_record_pre_action 12:22:17 INFO - Running main action method: download_and_extract 12:22:17 INFO - mkdir: /builds/slave/test/build/tests 12:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:17 INFO - trying https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:22:17 INFO - Downloading https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:22:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:22:18 INFO - Downloaded 1361 bytes. 12:22:18 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:22:18 INFO - Using the following test package requirements: 12:22:18 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 12:22:18 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:22:18 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:22:18 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:18 INFO - u'jsshell-linux-x86_64.zip'], 12:22:18 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:22:18 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 12:22:18 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:22:18 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:22:18 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:22:18 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:22:18 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:22:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 12:22:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:22:18 INFO - Fetch https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:22:18 INFO - Http code: 200 12:22:18 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 12:22:18 INFO - x-amz-cf-id: 75uW536Tm6R1VUjLeXT48sop5OUem_nNXfhUAZsWMFw9BM2RsGK3OA== 12:22:18 INFO - x-amz-version-id: lSNfA0QJD1q5ej.3aw4w0iJ.AwUV7cZX 12:22:19 INFO - Expected file size: 20320052 12:22:19 INFO - Obtained file size: 20320052 12:22:23 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:22:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 12:22:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:22:23 INFO - Fetch https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:22:23 INFO - Http code: 200 12:22:23 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 12:22:23 INFO - x-amz-cf-id: 0BIune4AIBx8_bl72X9V2FoEgZCIhxyeu1csjNgN6bP7wSFGGdsboA== 12:22:23 INFO - x-amz-version-id: lSNfA0QJD1q5ej.3aw4w0iJ.AwUV7cZX 12:22:23 INFO - Expected file size: 20320052 12:22:23 INFO - Obtained file size: 20320052 12:22:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 12:22:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:22:28 INFO - Fetch https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:22:29 INFO - Http code: 200 12:22:29 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 12:22:29 INFO - x-amz-cf-id: BK0JpiMzk0eyp-_uUm-W9c-Ni7sCZJnfEwnSYecknGiTWILZO92v_g== 12:22:29 INFO - x-amz-version-id: fqBh8L.l9Sjifn67pnULqETbJ0hQjb6C 12:22:29 INFO - Expected file size: 14409392 12:22:29 INFO - Obtained file size: 14409392 12:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:29 INFO - trying https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:22:29 INFO - Downloading https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:22:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:22:30 INFO - Downloaded 55701999 bytes. 12:22:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:22:30 INFO - mkdir: /builds/slave/test/properties 12:22:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:22:30 INFO - Writing to file /builds/slave/test/properties/build_url 12:22:30 INFO - Contents: 12:22:30 INFO - build_url:https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:22:31 INFO - Running post-action listener: _resource_record_post_action 12:22:31 INFO - Running post-action listener: set_extra_try_arguments 12:22:31 INFO - [mozharness: 2016-11-18 20:22:31.294153Z] Finished download-and-extract step (success) 12:22:31 INFO - [mozharness: 2016-11-18 20:22:31.294383Z] Running populate-webroot step. 12:22:31 INFO - Running pre-action listener: _resource_record_pre_action 12:22:31 INFO - Running main action method: populate_webroot 12:22:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:22:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:22:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:22:31 INFO - '--tppagecycles', 12:22:31 INFO - '7'], 12:22:31 INFO - 'tests': ['tsvgm']}}, 12:22:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:22:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:22:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:22:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:22:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:22:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:22:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:22:31 INFO - 'talos_options': ['--disable-e10s'], 12:22:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:22:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:22:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:22:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:22:31 INFO - 'talos_options': ['--disable-e10s'], 12:22:31 INFO - 'tests': ['damp', 'tps']}, 12:22:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:22:31 INFO - 'tests': ['damp', 'tps']}, 12:22:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:22:31 INFO - 'tests': ['dromaeo_dom']}, 12:22:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:22:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:22:31 INFO - 'tests': ['basic_compositor_video']}, 12:22:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:22:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:22:31 INFO - 'tests': ['a11yr', 12:22:31 INFO - 'ts_paint', 12:22:31 INFO - 'tpaint', 12:22:31 INFO - 'sessionrestore', 12:22:31 INFO - 'sessionrestore_no_auto_restore', 12:22:31 INFO - 'tabpaint']}, 12:22:31 INFO - 'other-e10s': {'tests': ['a11yr', 12:22:31 INFO - 'ts_paint', 12:22:31 INFO - 'tpaint', 12:22:31 INFO - 'sessionrestore', 12:22:31 INFO - 'sessionrestore_no_auto_restore', 12:22:31 INFO - 'tabpaint']}, 12:22:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:22:31 INFO - 'ts_paint', 12:22:31 INFO - 'tpaint', 12:22:31 INFO - 'sessionrestore', 12:22:31 INFO - 'sessionrestore_no_auto_restore', 12:22:31 INFO - 'tabpaint']}, 12:22:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:22:31 INFO - 'ts_paint', 12:22:31 INFO - 'tpaint', 12:22:31 INFO - 'sessionrestore', 12:22:31 INFO - 'sessionrestore_no_auto_restore', 12:22:31 INFO - 'tabpaint']}, 12:22:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:22:31 INFO - 'tests': ['a11yr', 12:22:31 INFO - 'ts_paint', 12:22:31 INFO - 'tpaint', 12:22:31 INFO - 'sessionrestore', 12:22:31 INFO - 'sessionrestore_no_auto_restore', 12:22:31 INFO - 'tabpaint']}, 12:22:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:22:31 INFO - 'tests': ['a11yr', 12:22:31 INFO - 'ts_paint', 12:22:31 INFO - 'tpaint', 12:22:31 INFO - 'sessionrestore', 12:22:31 INFO - 'sessionrestore_no_auto_restore', 12:22:31 INFO - 'tabpaint']}, 12:22:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:22:31 INFO - 'tests': ['tsvgx', 12:22:31 INFO - 'tsvgr_opacity', 12:22:31 INFO - 'tart', 12:22:31 INFO - 'tscrollx', 12:22:31 INFO - 'cart']}, 12:22:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:22:31 INFO - 'tsvgr_opacity', 12:22:31 INFO - 'tart', 12:22:31 INFO - 'tscrollx', 12:22:31 INFO - 'cart']}, 12:22:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:22:31 INFO - 'talos_options': ['--disable-e10s'], 12:22:31 INFO - 'tests': ['tp5o']}, 12:22:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:22:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:22:31 INFO - 'talos_options': ['--disable-e10s', 12:22:31 INFO - '--xperf_path', 12:22:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:22:31 INFO - 'tests': ['tp5n']}, 12:22:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:22:31 INFO - 'talos_options': ['--xperf_path', 12:22:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:22:31 INFO - 'tests': ['tp5n']}}, 12:22:31 INFO - 'talos.zip': {'path': '', 12:22:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:22:31 INFO - Running post-action listener: _resource_record_post_action 12:22:31 INFO - [mozharness: 2016-11-18 20:22:31.310941Z] Finished populate-webroot step (success) 12:22:31 INFO - [mozharness: 2016-11-18 20:22:31.311029Z] Running create-virtualenv step. 12:22:31 INFO - Running pre-action listener: _resource_record_pre_action 12:22:31 INFO - Running main action method: create_virtualenv 12:22:31 INFO - Creating virtualenv /builds/slave/test/build/venv 12:22:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:22:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:22:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:22:31 INFO - Using real prefix '/usr' 12:22:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:22:32 INFO - Installing distribute.............................................................................................................................................................................................done. 12:22:34 INFO - Installing pip.................done. 12:22:34 INFO - Return code: 0 12:22:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:22:34 INFO - Reading from file tmpfile_stdout 12:22:34 INFO - Output received: 12:22:34 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:22:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:34 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 0x7f184d3afe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd6130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c64fc0>, '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 0x1c65ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c66350>, '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': '826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:22:34 INFO - Using env: {'DISPLAY': ':0', 12:22:34 INFO - 'HOME': '/home/cltbld', 12:22:34 INFO - 'LANG': 'en_US.UTF-8', 12:22:34 INFO - 'LANGUAGE': 'en_US:en', 12:22:34 INFO - 'LOGNAME': 'cltbld', 12:22:34 INFO - 'MAIL': '/var/mail/cltbld', 12:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:34 INFO - 'MOZ_NO_REMOTE': '1', 12:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:34 INFO - 'NO_EM_RESTART': '1', 12:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:34 INFO - 'PWD': '/builds/slave/test', 12:22:34 INFO - 'SHELL': '/bin/bash', 12:22:34 INFO - 'SHLVL': '1', 12:22:34 INFO - 'TERM': 'linux', 12:22:34 INFO - 'TMOUT': '86400', 12:22:34 INFO - 'USER': 'cltbld', 12:22:34 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520', 12:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:34 INFO - '_': '/tools/buildbot/bin/python'} 12:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:22:34 INFO - Cleaning up... 12:22:34 INFO - Return code: 0 12:22:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:34 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 0x7f184d3afe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd6130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c64fc0>, '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 0x1c65ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c66350>, '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': '826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:22:34 INFO - Using env: {'DISPLAY': ':0', 12:22:34 INFO - 'HOME': '/home/cltbld', 12:22:34 INFO - 'LANG': 'en_US.UTF-8', 12:22:34 INFO - 'LANGUAGE': 'en_US:en', 12:22:34 INFO - 'LOGNAME': 'cltbld', 12:22:34 INFO - 'MAIL': '/var/mail/cltbld', 12:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:34 INFO - 'MOZ_NO_REMOTE': '1', 12:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:34 INFO - 'NO_EM_RESTART': '1', 12:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:34 INFO - 'PWD': '/builds/slave/test', 12:22:34 INFO - 'SHELL': '/bin/bash', 12:22:34 INFO - 'SHLVL': '1', 12:22:34 INFO - 'TERM': 'linux', 12:22:34 INFO - 'TMOUT': '86400', 12:22:34 INFO - 'USER': 'cltbld', 12:22:34 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520', 12:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:34 INFO - '_': '/tools/buildbot/bin/python'} 12:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:34 INFO - Downloading/unpacking psutil>=3.1.1 12:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:22:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:22:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:22:36 INFO - Installing collected packages: psutil 12:22:36 INFO - Running setup.py install for psutil 12:22:36 INFO - building 'psutil._psutil_linux' extension 12:22:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:22:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:22:38 INFO - building 'psutil._psutil_posix' extension 12:22:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:22:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:22:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:22:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:22:38 INFO - Successfully installed psutil 12:22:38 INFO - Cleaning up... 12:22:38 INFO - Return code: 0 12:22:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:22: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')]} 12:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22: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')]} 12:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:38 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 0x7f184d3afe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd6130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c64fc0>, '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 0x1c65ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c66350>, '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': '826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:22:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:22:38 INFO - Using env: {'DISPLAY': ':0', 12:22:38 INFO - 'HOME': '/home/cltbld', 12:22:38 INFO - 'LANG': 'en_US.UTF-8', 12:22:38 INFO - 'LANGUAGE': 'en_US:en', 12:22:38 INFO - 'LOGNAME': 'cltbld', 12:22:38 INFO - 'MAIL': '/var/mail/cltbld', 12:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:38 INFO - 'MOZ_NO_REMOTE': '1', 12:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:38 INFO - 'NO_EM_RESTART': '1', 12:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:38 INFO - 'PWD': '/builds/slave/test', 12:22:38 INFO - 'SHELL': '/bin/bash', 12:22:38 INFO - 'SHLVL': '1', 12:22:38 INFO - 'TERM': 'linux', 12:22:38 INFO - 'TMOUT': '86400', 12:22:38 INFO - 'USER': 'cltbld', 12:22:38 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520', 12:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:38 INFO - '_': '/tools/buildbot/bin/python'} 12:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:22:40 INFO - Installing collected packages: mozsystemmonitor 12:22:40 INFO - Running setup.py install for mozsystemmonitor 12:22:40 INFO - Successfully installed mozsystemmonitor 12:22:40 INFO - Cleaning up... 12:22:40 INFO - Return code: 0 12:22:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:40 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 0x7f184d3afe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd6130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c64fc0>, '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 0x1c65ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c66350>, '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': '826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:22:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:22:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:22:40 INFO - Using env: {'DISPLAY': ':0', 12:22:40 INFO - 'HOME': '/home/cltbld', 12:22:40 INFO - 'LANG': 'en_US.UTF-8', 12:22:40 INFO - 'LANGUAGE': 'en_US:en', 12:22:40 INFO - 'LOGNAME': 'cltbld', 12:22:40 INFO - 'MAIL': '/var/mail/cltbld', 12:22:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:40 INFO - 'MOZ_NO_REMOTE': '1', 12:22:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:40 INFO - 'NO_EM_RESTART': '1', 12:22:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:40 INFO - 'PWD': '/builds/slave/test', 12:22:40 INFO - 'SHELL': '/bin/bash', 12:22:40 INFO - 'SHLVL': '1', 12:22:40 INFO - 'TERM': 'linux', 12:22:40 INFO - 'TMOUT': '86400', 12:22:40 INFO - 'USER': 'cltbld', 12:22:40 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520', 12:22:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:40 INFO - '_': '/tools/buildbot/bin/python'} 12:22:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:40 INFO - Downloading/unpacking jsonschema==2.5.1 12:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:22:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:43 INFO - Downloading functools32-3.2.3-2.tar.gz 12:22:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:22:43 INFO - warning: no files found matching '*.txt' 12:22:43 INFO - no previously-included directories found matching 'build' 12:22:43 INFO - no previously-included directories found matching 'dist' 12:22:43 INFO - no previously-included directories found matching '.git*' 12:22:43 INFO - Installing collected packages: jsonschema, functools32 12:22:43 INFO - Running setup.py install for functools32 12:22:43 INFO - warning: no files found matching '*.txt' 12:22:43 INFO - no previously-included directories found matching 'build' 12:22:43 INFO - no previously-included directories found matching 'dist' 12:22:43 INFO - no previously-included directories found matching '.git*' 12:22:43 INFO - Successfully installed jsonschema functools32 12:22:43 INFO - Cleaning up... 12:22:43 INFO - Return code: 0 12:22:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f184d3afe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd6130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c64fc0>, '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 0x1c65ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c66350>, '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': '826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:22:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:22:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:22:43 INFO - Using env: {'DISPLAY': ':0', 12:22:43 INFO - 'HOME': '/home/cltbld', 12:22:43 INFO - 'LANG': 'en_US.UTF-8', 12:22:43 INFO - 'LANGUAGE': 'en_US:en', 12:22:43 INFO - 'LOGNAME': 'cltbld', 12:22:43 INFO - 'MAIL': '/var/mail/cltbld', 12:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:43 INFO - 'MOZ_NO_REMOTE': '1', 12:22:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:43 INFO - 'NO_EM_RESTART': '1', 12:22:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:43 INFO - 'PWD': '/builds/slave/test', 12:22:43 INFO - 'SHELL': '/bin/bash', 12:22:43 INFO - 'SHLVL': '1', 12:22:43 INFO - 'TERM': 'linux', 12:22:43 INFO - 'TMOUT': '86400', 12:22:43 INFO - 'USER': 'cltbld', 12:22:43 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520', 12:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:43 INFO - '_': '/tools/buildbot/bin/python'} 12:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:22:43 INFO - Cleaning up... 12:22:43 INFO - Return code: 0 12:22:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f184d3afe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd6130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c64fc0>, '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 0x1c65ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c66350>, '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': '826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:22:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:22:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:22:43 INFO - Using env: {'DISPLAY': ':0', 12:22:43 INFO - 'HOME': '/home/cltbld', 12:22:43 INFO - 'LANG': 'en_US.UTF-8', 12:22:43 INFO - 'LANGUAGE': 'en_US:en', 12:22:43 INFO - 'LOGNAME': 'cltbld', 12:22:43 INFO - 'MAIL': '/var/mail/cltbld', 12:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:43 INFO - 'MOZ_NO_REMOTE': '1', 12:22:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:43 INFO - 'NO_EM_RESTART': '1', 12:22:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:43 INFO - 'PWD': '/builds/slave/test', 12:22:43 INFO - 'SHELL': '/bin/bash', 12:22:43 INFO - 'SHLVL': '1', 12:22:43 INFO - 'TERM': 'linux', 12:22:43 INFO - 'TMOUT': '86400', 12:22:43 INFO - 'USER': 'cltbld', 12:22:43 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520', 12:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:43 INFO - '_': '/tools/buildbot/bin/python'} 12:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:43 INFO - Downloading/unpacking blobuploader==1.2.4 12:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:45 INFO - Downloading blobuploader-1.2.4.tar.gz 12:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:22:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:22:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:46 INFO - Downloading docopt-0.6.1.tar.gz 12:22:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:22:46 INFO - Installing collected packages: blobuploader, requests, docopt 12:22:46 INFO - Running setup.py install for blobuploader 12:22:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:22:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:22:46 INFO - Running setup.py install for requests 12:22:47 INFO - Running setup.py install for docopt 12:22:47 INFO - Successfully installed blobuploader requests docopt 12:22:47 INFO - Cleaning up... 12:22:47 INFO - Return code: 0 12:22:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:47 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 0x7f184d3afe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd6130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c64fc0>, '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 0x1c65ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c66350>, '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': '826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:22:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:22:47 INFO - Using env: {'DISPLAY': ':0', 12:22:47 INFO - 'HOME': '/home/cltbld', 12:22:47 INFO - 'LANG': 'en_US.UTF-8', 12:22:47 INFO - 'LANGUAGE': 'en_US:en', 12:22:47 INFO - 'LOGNAME': 'cltbld', 12:22:47 INFO - 'MAIL': '/var/mail/cltbld', 12:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:47 INFO - 'MOZ_NO_REMOTE': '1', 12:22:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:47 INFO - 'NO_EM_RESTART': '1', 12:22:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:47 INFO - 'PWD': '/builds/slave/test', 12:22:47 INFO - 'SHELL': '/bin/bash', 12:22:47 INFO - 'SHLVL': '1', 12:22:47 INFO - 'TERM': 'linux', 12:22:47 INFO - 'TMOUT': '86400', 12:22:47 INFO - 'USER': 'cltbld', 12:22:47 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520', 12:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:47 INFO - '_': '/tools/buildbot/bin/python'} 12:22:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:22:47 INFO - Running setup.py (path:/tmp/pip-PnZz1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:22:47 INFO - Running setup.py (path:/tmp/pip-3BZBR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:22:47 INFO - Running setup.py (path:/tmp/pip-3Pszcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:22:47 INFO - Running setup.py (path:/tmp/pip-lcOxz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:22:47 INFO - Running setup.py (path:/tmp/pip-ulMu8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:22:47 INFO - Running setup.py (path:/tmp/pip-uxntJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:22:47 INFO - Running setup.py (path:/tmp/pip-Wyq8oD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:22:47 INFO - Running setup.py (path:/tmp/pip-c59c8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:22:48 INFO - Running setup.py (path:/tmp/pip-yygJsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:22:48 INFO - Running setup.py (path:/tmp/pip-hCADFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:22:48 INFO - Running setup.py (path:/tmp/pip-k6v08p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:22:48 INFO - Running setup.py (path:/tmp/pip-seLXvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:22:48 INFO - Running setup.py (path:/tmp/pip-bp9fcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:22:48 INFO - Running setup.py (path:/tmp/pip-eJ4iXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:22:48 INFO - Running setup.py (path:/tmp/pip-yEkZ_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:22:48 INFO - Running setup.py (path:/tmp/pip-To9K5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:22:48 INFO - Running setup.py (path:/tmp/pip-zSLA4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:22:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:22:48 INFO - Running setup.py install for manifestparser 12:22:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:22:48 INFO - Running setup.py install for mozcrash 12:22:48 INFO - Running setup.py install for mozdebug 12:22:48 INFO - Running setup.py install for mozdevice 12:22:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:22:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:22:49 INFO - Running setup.py install for mozfile 12:22:49 INFO - Running setup.py install for mozhttpd 12:22:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:22:49 INFO - Running setup.py install for mozinfo 12:22:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:22:49 INFO - Running setup.py install for mozInstall 12:22:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:22:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:22:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:22:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:22:49 INFO - Running setup.py install for mozleak 12:22:49 INFO - Running setup.py install for mozlog 12:22:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:22:49 INFO - Running setup.py install for moznetwork 12:22:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:22:49 INFO - Running setup.py install for mozprocess 12:22:49 INFO - Running setup.py install for mozprofile 12:22:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:22:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:22:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:22:50 INFO - Running setup.py install for mozrunner 12:22:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:22:50 INFO - Running setup.py install for mozscreenshot 12:22:50 INFO - Running setup.py install for moztest 12:22:50 INFO - Running setup.py install for mozversion 12:22:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:22:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:22:50 INFO - Cleaning up... 12:22:50 INFO - Return code: 0 12:22:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:50 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 0x7f184d3afe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd6130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c64fc0>, '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 0x1c65ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c66350>, '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': '826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:22:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:22:50 INFO - Using env: {'DISPLAY': ':0', 12:22:50 INFO - 'HOME': '/home/cltbld', 12:22:50 INFO - 'LANG': 'en_US.UTF-8', 12:22:50 INFO - 'LANGUAGE': 'en_US:en', 12:22:50 INFO - 'LOGNAME': 'cltbld', 12:22:50 INFO - 'MAIL': '/var/mail/cltbld', 12:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:50 INFO - 'MOZ_NO_REMOTE': '1', 12:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:50 INFO - 'NO_EM_RESTART': '1', 12:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:50 INFO - 'PWD': '/builds/slave/test', 12:22:50 INFO - 'SHELL': '/bin/bash', 12:22:50 INFO - 'SHLVL': '1', 12:22:50 INFO - 'TERM': 'linux', 12:22:50 INFO - 'TMOUT': '86400', 12:22:50 INFO - 'USER': 'cltbld', 12:22:50 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520', 12:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:50 INFO - '_': '/tools/buildbot/bin/python'} 12:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:22:50 INFO - Running setup.py (path:/tmp/pip-Qol5Gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:22:50 INFO - Running setup.py (path:/tmp/pip-cHW4tZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:22:50 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)) 12:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:22:50 INFO - Running setup.py (path:/tmp/pip-3ilZEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:22:50 INFO - Running setup.py (path:/tmp/pip-u3T0qW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:22:51 INFO - Running setup.py (path:/tmp/pip-kbmTBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:22:51 INFO - Running setup.py (path:/tmp/pip-V1Z_QE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:22:51 INFO - Running setup.py (path:/tmp/pip-wodFdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:22:51 INFO - Running setup.py (path:/tmp/pip-YvUIPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:22:51 INFO - Running setup.py (path:/tmp/pip-8yBjBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:22:51 INFO - Running setup.py (path:/tmp/pip-5a2ACY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:22:51 INFO - Running setup.py (path:/tmp/pip-YJBLXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:22:51 INFO - Running setup.py (path:/tmp/pip-Vc0QN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:22:51 INFO - Running setup.py (path:/tmp/pip-qJvp_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:22:51 INFO - Running setup.py (path:/tmp/pip-96BW2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:22:51 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)) 12:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:22:51 INFO - Running setup.py (path:/tmp/pip-5HkmQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:22:51 INFO - Running setup.py (path:/tmp/pip-zgSbo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:22:51 INFO - Running setup.py (path:/tmp/pip-YOnsjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:22:51 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)) 12:22:51 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)) 12:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:22:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:53 INFO - Downloading blessings-1.6.tar.gz 12:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:22:54 INFO - Installing collected packages: blessings 12:22:54 INFO - Running setup.py install for blessings 12:22:54 INFO - Successfully installed blessings 12:22:54 INFO - Cleaning up... 12:22:54 INFO - Return code: 0 12:22:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:22:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:22:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:22:54 INFO - Reading from file tmpfile_stdout 12:22:54 INFO - Current package versions: 12:22:54 INFO - argparse == 1.2.1 12:22:54 INFO - blessings == 1.6 12:22:54 INFO - blobuploader == 1.2.4 12:22:54 INFO - docopt == 0.6.1 12:22:54 INFO - functools32 == 3.2.3-2 12:22:54 INFO - jsonschema == 2.5.1 12:22:54 INFO - manifestparser == 1.1 12:22:54 INFO - mozInstall == 1.12 12:22:54 INFO - mozcrash == 1.0 12:22:54 INFO - mozdebug == 0.1 12:22:54 INFO - mozdevice == 0.49 12:22:54 INFO - mozfile == 1.2 12:22:54 INFO - mozhttpd == 0.7 12:22:54 INFO - mozinfo == 0.9 12:22:54 INFO - mozleak == 0.1 12:22:54 INFO - mozlog == 3.4 12:22:54 INFO - moznetwork == 0.27 12:22:54 INFO - mozprocess == 0.23 12:22:54 INFO - mozprofile == 0.28 12:22:54 INFO - mozrunner == 6.13 12:22:54 INFO - mozscreenshot == 0.1 12:22:54 INFO - mozsystemmonitor == 0.3 12:22:54 INFO - moztest == 0.7 12:22:54 INFO - mozversion == 1.4 12:22:54 INFO - psutil == 3.1.1 12:22:54 INFO - requests == 1.2.3 12:22:54 INFO - wsgiref == 0.1.2 12:22:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:22: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')]} 12:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22: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')]} 12:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:54 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 0x7f184d3afe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd6130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c64fc0>, '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 0x1c65ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c66350>, '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': '826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:22:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:22:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:22:54 INFO - Using env: {'DISPLAY': ':0', 12:22:54 INFO - 'HOME': '/home/cltbld', 12:22:54 INFO - 'LANG': 'en_US.UTF-8', 12:22:54 INFO - 'LANGUAGE': 'en_US:en', 12:22:54 INFO - 'LOGNAME': 'cltbld', 12:22:54 INFO - 'MAIL': '/var/mail/cltbld', 12:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:54 INFO - 'MOZ_NO_REMOTE': '1', 12:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:54 INFO - 'NO_EM_RESTART': '1', 12:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:54 INFO - 'PWD': '/builds/slave/test', 12:22:54 INFO - 'SHELL': '/bin/bash', 12:22:54 INFO - 'SHLVL': '1', 12:22:54 INFO - 'TERM': 'linux', 12:22:54 INFO - 'TMOUT': '86400', 12:22:54 INFO - 'USER': 'cltbld', 12:22:54 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520', 12:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:54 INFO - '_': '/tools/buildbot/bin/python'} 12:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:22:54 INFO - Cleaning up... 12:22:54 INFO - Return code: 0 12:22:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:22: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')]} 12:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22: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')]} 12:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f184d3afe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd6130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c64fc0>, '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 0x1c65ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c66350>, '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': '826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:22: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', 'jsonschema'] in /builds/slave/test/build 12:22: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 jsonschema 12:22:54 INFO - Using env: {'DISPLAY': ':0', 12:22:54 INFO - 'HOME': '/home/cltbld', 12:22:54 INFO - 'LANG': 'en_US.UTF-8', 12:22:54 INFO - 'LANGUAGE': 'en_US:en', 12:22:54 INFO - 'LOGNAME': 'cltbld', 12:22:54 INFO - 'MAIL': '/var/mail/cltbld', 12:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:54 INFO - 'MOZ_NO_REMOTE': '1', 12:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:54 INFO - 'NO_EM_RESTART': '1', 12:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:54 INFO - 'PWD': '/builds/slave/test', 12:22:54 INFO - 'SHELL': '/bin/bash', 12:22:54 INFO - 'SHLVL': '1', 12:22:54 INFO - 'TERM': 'linux', 12:22:54 INFO - 'TMOUT': '86400', 12:22:54 INFO - 'USER': 'cltbld', 12:22:54 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520', 12:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:54 INFO - '_': '/tools/buildbot/bin/python'} 12:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:22:54 INFO - Cleaning up... 12:22:54 INFO - Return code: 0 12:22:54 INFO - Running post-action listener: _resource_record_post_action 12:22:54 INFO - Running post-action listener: _start_resource_monitoring 12:22:54 INFO - Starting resource monitoring. 12:22:54 INFO - [mozharness: 2016-11-18 20:22:54.942451Z] Finished create-virtualenv step (success) 12:22:54 INFO - [mozharness: 2016-11-18 20:22:54.942906Z] Running install step. 12:22:54 INFO - Running pre-action listener: _resource_record_pre_action 12:22:54 INFO - Running main action method: install 12:22:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:22:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:22:55 INFO - Reading from file tmpfile_stdout 12:22:55 INFO - Detecting whether we're running mozinstall >=1.0... 12:22:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:22:55 INFO - Reading from file tmpfile_stdout 12:22:55 INFO - Output received: 12:22:55 INFO - Usage: mozinstall [options] installer 12:22:55 INFO - Options: 12:22:55 INFO - -h, --help show this help message and exit 12:22:55 INFO - -d DEST, --destination=DEST 12:22:55 INFO - Directory to install application into. [default: 12:22:55 INFO - "/builds/slave/test"] 12:22:55 INFO - --app=APP Application being installed. [default: firefox] 12:22:55 INFO - mkdir: /builds/slave/test/build/application 12:22:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:23:11 INFO - Reading from file tmpfile_stdout 12:23:11 INFO - Output received: 12:23:11 INFO - /builds/slave/test/build/application/firefox/firefox 12:23:11 INFO - Running post-action listener: _resource_record_post_action 12:23:11 INFO - [mozharness: 2016-11-18 20:23:11.282753Z] Finished install step (success) 12:23:11 INFO - [mozharness: 2016-11-18 20:23:11.283012Z] Running run-tests step. 12:23:11 INFO - Running pre-action listener: _resource_record_pre_action 12:23:11 INFO - Running main action method: run_tests 12:23:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:23:11 INFO - Python 2.7.3 12:23:11 INFO - Return code: 0 12:23:11 INFO - grabbing minidump binary from tooltool 12:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:11 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 0x1c64fc0>, '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 0x1c65ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c66350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:23:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:23:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:23:11 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:23:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:23:11 INFO - Return code: 0 12:23:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:23:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:23:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:23:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:23:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:23:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:23:11 INFO - Using env: {'DISPLAY': ':0', 12:23:11 INFO - 'HOME': '/home/cltbld', 12:23:11 INFO - 'LANG': 'en_US.UTF-8', 12:23:11 INFO - 'LANGUAGE': 'en_US:en', 12:23:11 INFO - 'LOGNAME': 'cltbld', 12:23:11 INFO - 'MAIL': '/var/mail/cltbld', 12:23:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:23:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:11 INFO - 'MOZ_NO_REMOTE': '1', 12:23:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:11 INFO - 'NO_EM_RESTART': '1', 12:23:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:11 INFO - 'PWD': '/builds/slave/test', 12:23:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:23:11 INFO - 'SHELL': '/bin/bash', 12:23:11 INFO - 'SHLVL': '1', 12:23:11 INFO - 'TERM': 'linux', 12:23:11 INFO - 'TMOUT': '86400', 12:23:11 INFO - 'USER': 'cltbld', 12:23:11 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520', 12:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:11 INFO - '_': '/tools/buildbot/bin/python'} 12:23:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:23:11 INFO - mozversion application_buildid: 20161118110822 12:23:11 INFO - mozversion application_changeset: 7366f433e57d9b6fa35b2f4a0a59d22ee10e4ff6 12:23:11 INFO - mozversion application_display_name: Nightly 12:23:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:23:11 INFO - mozversion application_name: Firefox 12:23:11 INFO - mozversion application_remotingname: firefox 12:23:11 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 12:23:11 INFO - mozversion application_vendor: Mozilla 12:23:11 INFO - mozversion application_version: 53.0a1 12:23:11 INFO - mozversion platform_buildid: 20161118110822 12:23:11 INFO - mozversion platform_changeset: 7366f433e57d9b6fa35b2f4a0a59d22ee10e4ff6 12:23:11 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 12:23:11 INFO - mozversion platform_version: 53.0a1 12:23:11 INFO - using testdate: 1479500591 12:23:11 INFO - actual date: 1479500591 12:23:11 INFO - starting webserver on 'localhost:38602' 12:23:11 INFO - SUITE-START | Running 2 tests 12:23:11 INFO - TEST-START | dromaeo_css 12:23:11 INFO - operating with platform_type : linux_ 12:23:11 INFO - Initialising browser for dromaeo_css test... 12:23:11 INFO - TEST-INFO | started process 3322 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXVtzLo/profile http://localhost:38602/getInfo.html) 12:23:18 INFO - PROCESS | 3322 | __metrics Screen width/height:1600/1200 12:23:18 INFO - PROCESS | 3322 | colorDepth:24 12:23:18 INFO - PROCESS | 3322 | Browser inner width/height: 1024/697 12:23:18 INFO - PROCESS | 3322 | __metrics 12:23:19 ERROR - PROCESS | 3322 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 12:23:20 INFO - TEST-INFO | 3322: exit 0 12:23:20 INFO - Browser initialized. 12:23:20 INFO - Running cycle 1/1 for dromaeo_css test... 12:23:20 INFO - TEST-INFO | started process 3445 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXVtzLo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:23:32 INFO - PROCESS | 3445 | RSS: Main: 187887616 12:23:32 INFO - PROCESS | 3445 | 12:24:22 INFO - PROCESS | 3445 | 1479500662411 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:26:35 INFO - PROCESS | 3445 | Cycle 1(1): loaded http://localhost:38602/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38602/tests/dromaeo/cssquery-ext.html) 12:26:37 INFO - PROCESS | 3445 | RSS: Main: 197513216 12:26:37 INFO - PROCESS | 3445 | 12:29:39 INFO - PROCESS | 3445 | Cycle 1(1): loaded http://localhost:38602/tests/dromaeo/cssquery-ext.html (next: http://localhost:38602/tests/dromaeo/cssquery-jquery.html) 12:29:40 INFO - PROCESS | 3445 | RSS: Main: 197832704 12:29:40 INFO - PROCESS | 3445 | 12:32:42 INFO - PROCESS | 3445 | Cycle 1(1): loaded http://localhost:38602/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38602/tests/dromaeo/cssquery-mootools.html) 12:32:42 INFO - PROCESS | 3445 | RSS: Main: 199761920 12:32:42 INFO - PROCESS | 3445 | 12:35:45 INFO - PROCESS | 3445 | Cycle 1(1): loaded http://localhost:38602/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38602/tests/dromaeo/cssquery-prototype.html) 12:35:45 INFO - PROCESS | 3445 | RSS: Main: 196177920 12:35:45 INFO - PROCESS | 3445 | 12:38:48 INFO - PROCESS | 3445 | Cycle 1(1): loaded http://localhost:38602/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38602/tests/dromaeo/cssquery-yui.html) 12:38:49 INFO - PROCESS | 3445 | RSS: Main: 199512064 12:38:49 INFO - PROCESS | 3445 | 12:41:52 INFO - PROCESS | 3445 | Cycle 1(1): loaded http://localhost:38602/tests/dromaeo/cssquery-yui.html (next: http://localhost:38602/tests/dromaeo/cssquery-dojo.html) 12:41:52 INFO - PROCESS | 3445 | RSS: Main: 199380992 12:41:52 INFO - PROCESS | 3445 | 12:41:52 INFO - PROCESS | 3445 | __start_tp_report 12:41:52 INFO - PROCESS | 3445 | _x_x_mozilla_page_load 12:41:52 INFO - PROCESS | 3445 | _x_x_mozilla_page_load_details 12:41:52 INFO - PROCESS | 3445 | |i|pagename|runs| 12:41:52 INFO - PROCESS | 3445 | |0;dojo.html;2541.8220724549283;2564.705058918225;2570.07477308169;2592.131635901973;2592.7407259274064;4430.534793846648;4503.684742068052;4512.729236245827;4514.210013247681;4529.8188072477105;4466.82132714691;4486.327050942352;4564.9543504564945;4581.1753884300815;4593.448786145667;4119.5880411958715;4146.751194928306;4195.895102622444;4225.640820530259;4269.50900646425;4187.350960601112;4236.0468894498645;4258.9148217035645;4267.573242675739;4309.159713855799;4115.403266526367;4154.626083652486;4162.666986641061;4185.832566697329;4227.429297044921;4149.522804877417;4162.084341444877;4169.353750168729;4198.160367926396;4202.054537729017;4130.772807495587;4131.938020929689;4137.296659567881;4147.958520414787;4155.044339801832;4423.049044455425;4458.71018383804;4463.531329210418;4472.642188624902;4478.350639157336;4761.452432970218;4765.737884416356;4766.475687674353;4774.8567542973415;4779.402574678165;4763.54746299101;4821.4696383397795;4824.107540105092;4828.73441960692;4828.975855120702;4488.932666010012;4497.325401189848;4521.59305662492;4557.931631025537;4573.862784116482;4856.771546508822;4885.6335774817035;4893.437254715754;4911.165101932608;4918.8770280743265;4601.102784956901;4602.1025899949855;4737.028909073631;4746.786394612251;4778.928316075262;4750.239961606127;4751.216049351888;4753.453352864465;4756.096341695067;4827.348307978378;4811.398575178103;4818.566329030404;4819.566239038503;4828.275758636232;4854.2233242681705;4747.359106520645;4790.640701947368;4791.401074865642;4804.687695299865;4852.708837469763;3934.6655534279907;3965.5439624443557;4028.597140285948;4034;4071.918561628751;3510.736694747904;3531.2054787673083;3546.2375589248436;3550.0947258449446;3584.032311275941;4245;4248.745075295492;4249.851255206053;4281.721688090326;4281.850135245251;4672.813087476531;4854.854354369375;4857.732824694675;4865.416150061945;4932.062908047459;4164.5210800757695;4199.475065616798;4201.516825565038;4207.179599978036;4209.768462734518;4224.302990006676;4252.744835309892;4267.594578515036;4299.742015479019;4333.349997500401;4701.811927522861;4716.410448693913;4720.0559888022535;4721.787519561559;4759.547842954914;4884;4909.975450122869;4912.631552633496;4919.631027672867;4950.232713929347;4456.309272062836;4511.075229577863;4515.503294637653;4692.366530518337;4727.669063165546;4642.53574642533;4666.486686464418;4785.521447855187;4805.951940480551;4807.711537307633;4866.732329721899;4872.707637541759;4874.268859671078;4915.729634870117;4922.040202160688;4706.317583950239;4719.716816990992;4805.5915247204375;4806.903861922672;4841.515848415272;4568.269076947672;4623.630109591292;4647.209974304444;4659.743714095757;4795.760211989456;4566.908661826811;4576.496585375539;4616.653750968758;4701.670883038155;4714.457837348748;4806.567408933212;4814.735189564608;4816.831410900601;4853.830115945925;4860.489648586848;4624.075184962953;4666.78999445019;4693.718376897397;4704.3649107370065;4724.456687480983 12:41:52 INFO - PROCESS | 3445 | |1;ext.html;534.5322842512801;549.3490214096296;551.845483264686;561.3376216065046;561.5816216918396;36720.44919326209;38110.99999999996;38495.80752096239;42385.57614423855;42411;39144.608553914455;39480.60519394805;39714.40428393569;39748.60251397485;39850.60149398512;7518.699252029926;7715.575643339614;7715.884261736079;7717.2668596483245;7728.420368472387;7568.016157899493;7644.082710074799;7648.273414025659;7658.315170662446;7665.770026899174;7652.1582625911105;7690.807729806772;7708.30625243728;7713.267239612228;7721.03487064117;7647.847043059135;7680.308772210472;7682.347000504964;7696.807579810494;7710.113336966265;7552.207018263058;7612.314891659722;7619.5809230492305;7627.771166865003;7631.313181813608;36463.63536364656;36815.07962300937;36833.26333473343;36862;36901.26197476035;3004.309008927959;3030.5605687175234;3155.952660710091;3207.5990501187352;3332.3335332933266;27305.72694273052;27584.862075689693;27658.723412765816;27972;28608.427831443463;3433.3476639438677;3478.5477887874413;3515.2793677296095;3543.114221444639;3692.1692619160476;169173;169667;169899;170549.99999999875;170678;49306.75346623244;49540;49588.752056239486;49743;49746;52259.73870130625;52454.73772631113;52465.7376713114;52536;52622.47377526252;12385.256884586954;12469.127161098817;12471.438785254686;12493.750124997448;12571.622851314476;9256.7685807854;9261;9294.814103717888;9314.394564353295;9341.2994025447;14729.189894555902;14736.778948315783;14844;15029.774553381709;15188.544343669708;5841.211436456109;5861.443162899518;5918.201042859159;6019.358288235642;6071.119687645355;774.8372841703193;793.4287313134533;865.2083343740533;967.2165545907837;977.8705595037743;25720.485590288088;27346.069639804235;27481.17556473309;27768.58347124795;27835.860820695765;924.2236521322121;925.3106435705442;929.6002718830832;939.5865819039601;986.1617625018677;14591;14621.26893655313;14745.618698851702;14811.333489992976;14847.554573362817;353309;354260;355746;356230;357460;48185.277220841715;48336;48527.27209091866;48535.5146448531;48852;1130.5647325779635;1159.3855256713955;1180.2151569206553;1188.714708469961;1189.6847335456112;25352.619710704723;26238.34404139912;26761.866190668923;26972;27147.321316967234;41257.58742412658;42304;42315.788421057696;42335;42391.7880410596;320905;323067;323329;323383;324226;23038.308850734506;23387.883060584587;23397.88301058484;23404.6489302664;23493.17773877906;39912;40136;40292.19415611613;40842.59157408507;41325.1734965293;34119.82940085284;34517.65482345144;34540.82729586336;34662.30675386428;34856.65143348534;33303.66696333102;34074;34076.82961585176;34323;34464.65535344614;33473.83263083669;33999.32001359909;34075.48886766651;34186.65813341835;34501.827490862386;30257.09228723142;31711.841440792647;31910.202244944063;32027;32211.516827247142;24314.51370972606;24761.504769904863;24884.875575622005;25050.37374065663;25133 12:41:52 INFO - PROCESS | 3445 | |2;jquery.html;329.6225821434456;337.44102247616013;345.44211099074994;346.7208896838047;356.13281659159946;13800.86199138007;15390;15988.920055399707;16121.758173627404;16684.165791710428;16238.350465981346;16500;16732.079735614538;16743.916280418613;16766.07786571738;4790.80836766529;4862.319275301461;5020.196768517038;5040.722760248185;5046.293518907356;4933.062718083571;4983.277424773406;5002;5032.320636714052;5045.848624541251;5000.099982003256;5011.899762004758;5558.110702287635;5855.297364316288;5897.587168898179;5870.383609720981;5907.763689452417;5922.970385148046;5926.792562260343;5931.822045338647;5045.672031317989;5207.505286997767;5260.1583746600745;5262.947370526323;5264.947350526484;11368.488418021127;11543.711407214803;11592.188546801728;15656.295466704025;19395.418137455898;1815.3374018483291;1919.3090487424515;1948.366780796247;2101.4536220582604;2367.3963139399516;8263.55661881974;8535.402521823475;8847.955760221157;9010.459372437675;9081.455112693193;1669.2571805546536;1727.904965226912;1755.4996825904684;1764.1179410294853;1766.938157164506;66010.99999999952;67208;68096.6595167021;69463.65268173677;70786.64606676933;9476.289278304155;9505.382150160218;9644;9801.11789938909;9866.80266394668;12995.415206315738;13005.349732513336;13021.544245951347;13035.608931732064;13050.347482625832;6462.676866156673;6620.585697710197;6636.469082473391;6673.132492776005;6704.195496540447;6132.049532322497;6140.4473597376455;6186.412290832363;6337.651429171347;6354.3010268870385;4090.5295890972325;4107.096438783463;4114.814833332507;4132.760171948404;4219.936700949488;1714.7856517935259;1716.7253239481622;1731.6363563651773;1732.3157352845556;1749.9212535435936;725.9600721960237;743.695085015152;758.4349659503595;779.1273773373857;883.4610887358706;15177.848221517865;15573.299201535958;16049.438269660506;16258.75611865823;16632.50102496927;781.4686013510753;782.5617654113714;786.7600381883581;791.8257983243677;820.4912953968578;8469.788255293544;8702;8813.91186088131;9057.909420905838;9219.124183202584;361493;362688;373465;376395.95050618675;378327;46405.76797115993;47200;56254.71872640611;75695.62152189204;78023.2197678016;859.3855393393753;892.2638822971074;896.4979611417497;896.5114012863005;898.1557336104041;12036;14408.42366305378;14702.117872927658;14926.925365373103;15414.152221627917;36513.087172820895;36699.26601468009;36995.815020924725;37025.629743702215;37072.44391334078;47247.52752472569;49647.25529117139;51373.74313128411;57383.713081436;57405.13892291536;6849.452043836382;7192.604406757679;7286.052813134259;7286.089238845145;7456.47804653669;7371.41028717712;7945.523268603903;8007.519548827089;8106.392020598597;10878.456077196266;4385.298352263622;6955.478339124485;6999.860002800017;7453;7604.8479030420185;6954.721811127498;7155.105611798525;7261.056062711814;7336.339729424378;7398.186199518156;7164.360620439386;7322.926770732224;7395.223501532261;7423.294786995227;7790.298873101221;10775.784484310114;11068.667939961813;11206.7758644825;11258.38078905668;11511;10823.67528974132;10913.727156821144;10914.781704366027;11147.88852111501;11249.71875703114 12:41:52 INFO - PROCESS | 3445 | |3;mootools.html;1331.3875617216083;1372.3069849725887;1427;1569;1630.0952971101042;5990.371011043843;6192.318844927055;6419.518536109793;6978.755743548977;6987.2663370346145;6477.935220647792;6713.160854893138;6715.8656826863435;6821.795346139611;6834.863302733942;2038.8980550972467;2071.4510654676524;2076.7923207679264;2078.4699901525164;2081.864678795881;1875.39049808812;1895.7440745499318;1903.3148066695978;1913.8277555020045;1921.567647279365;2003.168684995725;2010.1155491583656;2017.3040301096098;2024.6659301215282;2030.5431277962414;2019.656658368081;2040.2757021257462;2043.0601923115385;2044.7955204479433;2047.5802460495563;2020.6362854686151;2042.9489262768402;2046.723692301535;2049.92825251117;2061.7835127311714;6710.295418981034;6730.596164230113;6746.156730408699;6848.452123830081;6859.55412898165;4003.4195041718785;4124.670026397881;4139.668826493873;4140.213359461723;4141.295979683461;2650.2314328844614;2743.629610002644;2778.749912507884;2791.204506715597;2807.536756435186;871.6121326009928;901.2969883490888;918.091089821079;920.1442658327752;935.5930170375908;8644.35167362444;8665.610047547812;8710.433821801626;8712.738617841474;8766.736997890073;3500.493746686024;3594.4248920172645;3644.6902013328636;3655.1227705351057;3711.9072023199637;7650.38796896247;7678.616069196518;7701;7728.420368472387;7729.497582657109;4180.707350485498;4201.894952626148;4206.053637931502;4209.095044565433;4211.789410529523;3387.796732196076;3491.0574144980715;3684.1894783147663;3759.6992240620684;3822.6177382261553;3223.9838800805846;3232.3858466891215;3349.681780230874;3362.00820757877;3375.4261775498226;1073.6058589345803;1085.6634443322596;1090.1987039525943;1091.5197313182175;1094.6770702642739;707.6355676826438;833.4207725630629;835.1856939483954;842.2293601354814;846.6655671009917;4701.294805779161;4797.18447863864;4803.879903002383;4861.586765124934;5056.089903817275;384.4579143407782;390.6171951487558;391.6083916083916;393.0547034382315;395.4305799648497;3314.303996160785;3344.364570731553;3355.194753259249;3383.7293016558615;3439.5872495300723;7478.401727861867;7691.5769632670745;7822.530648161129;7831.960840195877;7840.882386764203;7613.5431874087735;7754.108277548155;7797.103333116651;7799.181085986003;7828.686852525835;6170.259568851677;6221.813345599639;6243.687815609202;6248.500119990481;6263.498920086382;4726.692764970266;4745.738984355894;4776.880577985439;4791.736454495036;4864.464908860094;7035.648217589202;7159.248278930846;7220.205777364591;7251.23861994483;7308.524945878501;7404.259574042552;7435.182129965591;7480.401567874448;7481.064866891638;7542.245775422414;5816.883662326645;5937.495312898452;5940.227770389822;5955.970220148872;6067.635941843503;6501.837454063686;6617.470602351897;6623.437007854193;6627.734890604322;6627.867442651216;5953.345132035559;6000.429959153874;6125.111858780541;6135.907961380493;6161.106639537153;5877.617954832922;5922.881542369215;5936.614120082181;5939.703014849327;5949.077892926603;5543.695096769717;5546.362168350692;5558.610897237155;5562.9721851392105;5602.915956260578;3929.4498770172772;4032.9596704032583;4137.8965525862095;4150.418941348274;4187.58124187591;4215.367694845675;4221.767802770877;4277.550857160078;4309.116631090556;4360.040791025969 12:41:52 INFO - PROCESS | 3445 | |4;prototype.html;275.6678202765667;284.63234159861867;287.05987889661355;289.73199790194076;290.81782553918305;4712.269598212274;4798.752324395656;4842.322074909511;4844.854654360366;4895.779689913954;4769.737664428455;4787.928181077286;4793.281007848825;4799.328094066834;4808.687435316702;3597.172650290435;3701.444783282502;3704.851805927773;3707.8876337098895;3735.5345471988426;3694.242680250542;3706.3328600851837;3717.2379662169324;3730.5150330457004;3731.2910546995986;3638.1268495561008;3675.9632403675887;3676.963230367689;3695.6858667013203;3699.075231192202;3684.373656478405;3706.5552133743854;3710.5732840723394;3715.8885233442907;3725.4598083278042;2969.85150742462;3084.629844418662;3116.750659947199;3143.6227652681596;3149.3071524264624;4617.8152873885;4655.604273636745;4656.627469802408;4678.836240731592;4682.157211701892;4074.9185016299803;4076.490438695163;4098.446709694183;4102.466679331697;4127.545969943304;4792.18532849413;4895.485973972753;4902.534259245366;4941.950580494185;5000.374953130859;3435.055359776057;3444.207832198583;3453.1698199954067;3469.670381313771;3473.3574288756663;5158.716270605115;5160.870978225575;5163.561097306771;5172.741362931838;5196.68819870809;3510.596281427617;3512.24486735348;3540;3555.822208889545;3557.94663080054;3503.3343664703625;3576.8211589420425;3584.9103772405897;3585.964140358563;3588.1926566522325;4078.490188726409;4090.856820011345;4103.363978583325;4116.300228961084;4120.896977575585;4893.996730670276;4908.950910490849;4927.77824997876;4940.752962351868;5024.57291130258;1167.854018247719;1199.322382853685;1210.3766560221493;1214.5384753793503;1215.1858254969193;802.2699343597299;814.8795406316315;816.8284660221301;818.9549574773325;819.148085990575;4272.073629563759;4286.357046443059;4316.525182229952;4320.567943205654;4386.18855511725;5114.105031619526;5122.335241046675;5137.40919794221;5139.280500729901;5158.845234642967;4403.119376124788;4421.845235416745;4492.932606010912;4502.752348620792;4512.842050528216;2597.6752905886765;2646.287555255878;2668.5196664600558;2676.487784401807;2697.5414179589516;4815.686980346336;4821.035792841446;4823.14308991041;4859.975700121477;4869.269609558594;5063.733891639945;5091.5123140648775;5133.922991155136;5138.845834624967;5146.228065790161;4639.584926597353;4759.785809638505;4781.95218047822;4790.568848803624;4794.232922732485;4974.278729584118;4988.725620090785;5017.297578338962;5021.372328458942;5022.648414611088;4879.585235255043;4899.681520701143;4902.700784292237;4905.969746353163;4907.337509436323;4581.885452863705;4809.893724443327;4829.27560865873;4849.75751212445;4858.5384388483035;3463.1169051891607;3475.878344257939;3476.5654293213347;3491.336646037245;3497.5199676322222;5008.348914641073;5022.974885125551;5032.194848824171;5046.21783623539;5062.417821950523;4629.837955671535;4864.805407783649;4918.6065114791445;4918.950810491992;4945.727984960861;4839.370881785346;4848.9757551212015;4859.979404325131;4860.465348811557;4873.390826146731;4745.979614382924;4760.761961901961;4813.785658596945;4820.842997680602;4835.637327200544;4735.266033764772;4893.9021219576125;4899.755012249445;4917.6311776616185;4927.876803079952;4771.731364015661;4785.330053792402;4785.473597904158;4786.282057691375;4811.3264143019305 12:41:52 INFO - PROCESS | 3445 | |5;yui.html;597.6742675241993;627.272364057693;650.6746626686656;719.5287086958041;737.8671839068969;11781.410929453525;12223.633291001262;12483.687907802287;12506.874931250673;12572.685682857933;11934.104942129354;11979.341136237503;11993.340366279852;12005.279683219012;12100.27398356097;739.8261408568982;773.2924374197603;781.7342103684746;782.7612578163686;783.0094929913636;744.13680131048;754.3098065270271;780.3328154427968;781.3749000799338;783.7296132834163;813.7314686153585;814.2346194577108;814.6252723747084;815.759350991459;817.7628487738549;800.8478389106081;801.5511313664338;802.6468353924283;802.7391097893208;803.4656953126164;592.4726992976255;592.5378205000106;592.6325678079618;592.937741537141;593.0274350065895;12447;12455.439505222286;12477.376131193494;12479.688007799787;12552.121351505399;11054.889451105546;11120.221584489089;11228.438578071064;11594.246373985749;11836.289822610672;10795.46022698862;10919.39943303118;11035.83446248299;11052;11387.202895797298;3988.8205030773684;3989.4614227079264;4015.9196816063513;4027.07377303219;4063.1061166543313;46774.766126169154;48081.75959120217;48700.512994869954;49448.50551494475;49832.252516212284;9392.765180870396;9443.480608566457;9607.327487075978;9681.37071090377;9749.707508774749;16266.186690665656;16286;16354.427595034116;16408.917955410147;16411.91794041022;6319.46284565817;6413.6793160341795;6417.903731444032;6443.29123796382;6693.364130407604;3453.8963831085107;3547.095490649919;3593.6047034826147;3658.158623516606;3683.5027271318563;2588.818782685194;2648.7880969522394;2664.160789351387;2666.1734862192784;2668.8799004044863;470.7528547512515;471.29541335703345;473.1365258403359;477.49147158276327;484.8739327774804;449.2833929881833;499.49301459019125;510.81610620176707;522.6048928511202;538.5825984861764;6818.2159051708695;6894.620795856175;6981.965090174618;8287.751367458986;8367.874481882776;583.8744669895992;588.8174665853599;590.447931184344;608.6834845880206;610.91141784441;3562.964370356315;3626.673599376069;3674.9081272968388;3749.9812500937865;3823.311803875329;49987.25019124716;51936.740316298936;52315.73842130765;58100.418995810345;63051.684741576;53909.730451347496;55948.72025639927;56360.71819640876;56372.15441768377;57094.143587846214;51309.48690513047;52356.73821630867;53137.46862531325;53730;54818.725906370215;7774.455788094779;7854.72508462201;7947.364210863233;8084.39367047462;8111.107778144517;26301.34246643849;35279;36000.63999360077;36114.45828312525;37558.62441375551;44592.77703611591;45393.319100212866;48261.276080858115;49053.264201037724;51372;9689.806203876024;9891.653792117242;9960.900390996287;10106.646267380607;10208.846867297145;11770.76458470843;11966.341851198267;12284.938575307066;12409.565665201675;12612.810807838074;10298.279120461795;10818.459077045958;10998.12015038779;11311.490982905954;11558.826617600575;10633.734156646145;10694.572217111228;11001.064909482784;11296.774064518499;11349.716257093638;10785.838212426977;11612.129090318429;11665.416729163677;11674.70813229676;11870.406479675808;8906.86639700392;9042.773930651787;9256.861147082664;9290.349675522648;9294.72115836526;8842.557872106498;9401.388909720847;9424.340296179202;9429.292803039662;9564.56959436841 12:41:52 INFO - PROCESS | 3445 | __end_tp_report 12:41:52 INFO - PROCESS | 3445 | __start_cc_report 12:41:52 INFO - PROCESS | 3445 | _x_x_mozilla_cycle_collect,354 12:41:52 INFO - PROCESS | 3445 | __end_cc_report 12:41:52 INFO - PROCESS | 3445 | __startTimestamp1479501712718__endTimestamp 12:41:52 INFO - PROCESS | 3445 | 12:41:52 INFO - PROCESS | 3445 | ------- Summary: start ------- 12:41:52 INFO - PROCESS | 3445 | Number of tests: 6 12:41:52 INFO - PROCESS | 3445 | 12:41:52 INFO - PROCESS | 3445 | [#0] dojo.html Cycles:165 Average:4474.03 Median:4602.10 stddev:464.09 (10.1%) stddev-sans-first:440.06 12:41:52 INFO - PROCESS | 3445 | Values: 2541.8 2564.7 2570.1 2592.1 2592.7 4430.5 4503.7 4512.7 4514.2 4529.8 4466.8 4486.3 4565.0 4581.2 4593.4 4119.6 4146.8 4195.9 4225.6 4269.5 4187.4 4236.0 4258.9 4267.6 4309.2 4115.4 4154.6 4162.7 4185.8 4227.4 4149.5 4162.1 4169.4 4198.2 4202.1 4130.8 4131.9 4137.3 4148.0 4155.0 4423.0 4458.7 4463.5 4472.6 4478.4 4761.5 4765.7 4766.5 4774.9 4779.4 4763.5 4821.5 4824.1 4828.7 4829.0 4488.9 4497.3 4521.6 4557.9 4573.9 4856.8 4885.6 4893.4 4911.2 4918.9 4601.1 4602.1 4737.0 4746.8 4778.9 4750.2 4751.2 4753.5 4756.1 4827.3 4811.4 4818.6 4819.6 4828.3 4854.2 4747.4 4790.6 4791.4 4804.7 4852.7 3934.7 3965.5 4028.6 4034.0 4071.9 3510.7 3531.2 3546.2 3550.1 3584.0 4245.0 4248.7 4249.9 4281.7 4281.9 4672.8 4854.9 4857.7 4865.4 4932.1 4164.5 4199.5 4201.5 4207.2 4209.8 4224.3 4252.7 4267.6 4299.7 4333.3 4701.8 4716.4 4720.1 4721.8 4759.5 4884.0 4910.0 4912.6 4919.6 4950.2 4456.3 4511.1 4515.5 4692.4 4727.7 4642.5 4666.5 4785.5 4806.0 4807.7 4866.7 4872.7 4874.3 4915.7 4922.0 4706.3 4719.7 4805.6 4806.9 4841.5 4568.3 4623.6 4647.2 4659.7 4795.8 4566.9 4576.5 4616.7 4701.7 4714.5 4806.6 4814.7 4816.8 4853.8 4860.5 4624.1 4666.8 4693.7 4704.4 4724.5 12:41:52 INFO - PROCESS | 3445 | 12:41:52 INFO - PROCESS | 3445 | [#1] ext.html Cycles:180 Average:43538.18 Median:36767.76 stddev:77619.87 (211.1%) stddev-sans-first:77770.46 12:41:52 INFO - PROCESS | 3445 | Values: 534.5 549.3 551.8 561.3 561.6 36720.4 38111.0 38495.8 42385.6 42411.0 39144.6 39480.6 39714.4 39748.6 39850.6 7518.7 7715.6 7715.9 7717.3 7728.4 7568.0 7644.1 7648.3 7658.3 7665.8 7652.2 7690.8 7708.3 7713.3 7721.0 7647.8 7680.3 7682.3 7696.8 7710.1 7552.2 7612.3 7619.6 7627.8 7631.3 36463.6 36815.1 36833.3 36862.0 36901.3 3004.3 3030.6 3156.0 3207.6 3332.3 27305.7 27584.9 27658.7 27972.0 28608.4 3433.3 3478.5 3515.3 3543.1 3692.2 169173.0 169667.0 169899.0 170550.0 170678.0 49306.8 49540.0 49588.8 49743.0 49746.0 52259.7 52454.7 52465.7 52536.0 52622.5 12385.3 12469.1 12471.4 12493.8 12571.6 9256.8 9261.0 9294.8 9314.4 9341.3 14729.2 14736.8 14844.0 15029.8 15188.5 5841.2 5861.4 5918.2 6019.4 6071.1 774.8 793.4 865.2 967.2 977.9 25720.5 27346.1 27481.2 27768.6 27835.9 924.2 925.3 929.6 939.6 986.2 14591.0 14621.3 14745.6 14811.3 14847.6 353309.0 354260.0 355746.0 356230.0 357460.0 48185.3 48336.0 48527.3 48535.5 48852.0 1130.6 1159.4 1180.2 1188.7 1189.7 25352.6 26238.3 26761.9 26972.0 27147.3 41257.6 42304.0 42315.8 42335.0 42391.8 320905.0 323067.0 323329.0 323383.0 324226.0 23038.3 23387.9 23397.9 23404.6 23493.2 39912.0 40136.0 40292.2 40842.6 41325.2 34119.8 34517.7 34540.8 34662.3 34856.7 33303.7 34074.0 34076.8 34323.0 34464.7 33473.8 33999.3 34075.5 34186.7 34501.8 30257.1 31711.8 31910.2 32027.0 32211.5 24314.5 24761.5 24884.9 25050.4 25133.0 12:41:52 INFO - PROCESS | 3445 | 12:41:52 INFO - PROCESS | 3445 | [#2] jquery.html Cycles:180 Average:22682.89 Median:5043.20 stddev:61144.37 (1212.4%) stddev-sans-first:61292.86 12:41:52 INFO - PROCESS | 3445 | Values: 329.6 337.4 345.4 346.7 356.1 13800.9 15390.0 15988.9 16121.8 16684.2 16238.4 16500.0 16732.1 16743.9 16766.1 4790.8 4862.3 5020.2 5040.7 5046.3 4933.1 4983.3 5002.0 5032.3 5045.8 5000.1 5011.9 5558.1 5855.3 5897.6 5870.4 5907.8 5923.0 5926.8 5931.8 5045.7 5207.5 5260.2 5262.9 5264.9 11368.5 11543.7 11592.2 15656.3 19395.4 1815.3 1919.3 1948.4 2101.5 2367.4 8263.6 8535.4 8848.0 9010.5 9081.5 1669.3 1727.9 1755.5 1764.1 1766.9 66011.0 67208.0 68096.7 69463.7 70786.6 9476.3 9505.4 9644.0 9801.1 9866.8 12995.4 13005.3 13021.5 13035.6 13050.3 6462.7 6620.6 6636.5 6673.1 6704.2 6132.0 6140.4 6186.4 6337.7 6354.3 4090.5 4107.1 4114.8 4132.8 4219.9 1714.8 1716.7 1731.6 1732.3 1749.9 726.0 743.7 758.4 779.1 883.5 15177.8 15573.3 16049.4 16258.8 16632.5 781.5 782.6 786.8 791.8 820.5 8469.8 8702.0 8813.9 9057.9 9219.1 361493.0 362688.0 373465.0 376396.0 378327.0 46405.8 47200.0 56254.7 75695.6 78023.2 859.4 892.3 896.5 896.5 898.2 12036.0 14408.4 14702.1 14926.9 15414.2 36513.1 36699.3 36995.8 37025.6 37072.4 47247.5 49647.3 51373.7 57383.7 57405.1 6849.5 7192.6 7286.1 7286.1 7456.5 7371.4 7945.5 8007.5 8106.4 10878.5 4385.3 6955.5 6999.9 7453.0 7604.8 6954.7 7155.1 7261.1 7336.3 7398.2 7164.4 7322.9 7395.2 7423.3 7790.3 10775.8 11068.7 11206.8 11258.4 11511.0 10823.7 10913.7 10914.8 11147.9 11249.7 12:41:52 INFO - PROCESS | 3445 | 12:41:52 INFO - PROCESS | 3445 | [#3] mootools.html Cycles:180 Average:4461.53 Median:4800.53 stddev:2349.55 (48.9%) stddev-sans-first:2344.36 12:41:52 INFO - PROCESS | 3445 | Values: 1331.4 1372.3 1427.0 1569.0 1630.1 5990.4 6192.3 6419.5 6978.8 6987.3 6477.9 6713.2 6715.9 6821.8 6834.9 2038.9 2071.5 2076.8 2078.5 2081.9 1875.4 1895.7 1903.3 1913.8 1921.6 2003.2 2010.1 2017.3 2024.7 2030.5 2019.7 2040.3 2043.1 2044.8 2047.6 2020.6 2042.9 2046.7 2049.9 2061.8 6710.3 6730.6 6746.2 6848.5 6859.6 4003.4 4124.7 4139.7 4140.2 4141.3 2650.2 2743.6 2778.7 2791.2 2807.5 871.6 901.3 918.1 920.1 935.6 8644.4 8665.6 8710.4 8712.7 8766.7 3500.5 3594.4 3644.7 3655.1 3711.9 7650.4 7678.6 7701.0 7728.4 7729.5 4180.7 4201.9 4206.1 4209.1 4211.8 3387.8 3491.1 3684.2 3759.7 3822.6 3224.0 3232.4 3349.7 3362.0 3375.4 1073.6 1085.7 1090.2 1091.5 1094.7 707.6 833.4 835.2 842.2 846.7 4701.3 4797.2 4803.9 4861.6 5056.1 384.5 390.6 391.6 393.1 395.4 3314.3 3344.4 3355.2 3383.7 3439.6 7478.4 7691.6 7822.5 7832.0 7840.9 7613.5 7754.1 7797.1 7799.2 7828.7 6170.3 6221.8 6243.7 6248.5 6263.5 4726.7 4745.7 4776.9 4791.7 4864.5 7035.6 7159.2 7220.2 7251.2 7308.5 7404.3 7435.2 7480.4 7481.1 7542.2 5816.9 5937.5 5940.2 5956.0 6067.6 6501.8 6617.5 6623.4 6627.7 6627.9 5953.3 6000.4 6125.1 6135.9 6161.1 5877.6 5922.9 5936.6 5939.7 5949.1 5543.7 5546.4 5558.6 5563.0 5602.9 3929.4 4033.0 4137.9 4150.4 4187.6 4215.4 4221.8 4277.6 4309.1 4360.0 12:41:52 INFO - PROCESS | 3445 | 12:41:52 INFO - PROCESS | 3445 | [#4] prototype.html Cycles:180 Average:4080.07 Median:4752.88 stddev:1199.41 (25.2%) stddev-sans-first:1168.29 12:41:52 INFO - PROCESS | 3445 | Values: 275.7 284.6 287.1 289.7 290.8 4712.3 4798.8 4842.3 4844.9 4895.8 4769.7 4787.9 4793.3 4799.3 4808.7 3597.2 3701.4 3704.9 3707.9 3735.5 3694.2 3706.3 3717.2 3730.5 3731.3 3638.1 3676.0 3677.0 3695.7 3699.1 3684.4 3706.6 3710.6 3715.9 3725.5 2969.9 3084.6 3116.8 3143.6 3149.3 4617.8 4655.6 4656.6 4678.8 4682.2 4074.9 4076.5 4098.4 4102.5 4127.5 4792.2 4895.5 4902.5 4942.0 5000.4 3435.1 3444.2 3453.2 3469.7 3473.4 5158.7 5160.9 5163.6 5172.7 5196.7 3510.6 3512.2 3540.0 3555.8 3557.9 3503.3 3576.8 3584.9 3586.0 3588.2 4078.5 4090.9 4103.4 4116.3 4120.9 4894.0 4909.0 4927.8 4940.8 5024.6 1167.9 1199.3 1210.4 1214.5 1215.2 802.3 814.9 816.8 819.0 819.1 4272.1 4286.4 4316.5 4320.6 4386.2 5114.1 5122.3 5137.4 5139.3 5158.8 4403.1 4421.8 4492.9 4502.8 4512.8 2597.7 2646.3 2668.5 2676.5 2697.5 4815.7 4821.0 4823.1 4860.0 4869.3 5063.7 5091.5 5133.9 5138.8 5146.2 4639.6 4759.8 4782.0 4790.6 4794.2 4974.3 4988.7 5017.3 5021.4 5022.6 4879.6 4899.7 4902.7 4906.0 4907.3 4581.9 4809.9 4829.3 4849.8 4858.5 3463.1 3475.9 3476.6 3491.3 3497.5 5008.3 5023.0 5032.2 5046.2 5062.4 4629.8 4864.8 4918.6 4919.0 4945.7 4839.4 4849.0 4860.0 4860.5 4873.4 4746.0 4760.8 4813.8 4820.8 4835.6 4735.3 4893.9 4899.8 4917.6 4927.9 4771.7 4785.3 4785.5 4786.3 4811.3 12:41:52 INFO - PROCESS | 3445 | 12:41:52 INFO - PROCESS | 3445 | [#5] yui.html Cycles:180 Average:13771.18 Median:49640.38 stddev:16782.48 (33.8%) stddev-sans-first:16800.41 12:41:52 INFO - PROCESS | 3445 | Values: 597.7 627.3 650.7 719.5 737.9 11781.4 12223.6 12483.7 12506.9 12572.7 11934.1 11979.3 11993.3 12005.3 12100.3 739.8 773.3 781.7 782.8 783.0 744.1 754.3 780.3 781.4 783.7 813.7 814.2 814.6 815.8 817.8 800.8 801.6 802.6 802.7 803.5 592.5 592.5 592.6 592.9 593.0 12447.0 12455.4 12477.4 12479.7 12552.1 11054.9 11120.2 11228.4 11594.2 11836.3 10795.5 10919.4 11035.8 11052.0 11387.2 3988.8 3989.5 4015.9 4027.1 4063.1 46774.8 48081.8 48700.5 49448.5 49832.3 9392.8 9443.5 9607.3 9681.4 9749.7 16266.2 16286.0 16354.4 16408.9 16411.9 6319.5 6413.7 6417.9 6443.3 6693.4 3453.9 3547.1 3593.6 3658.2 3683.5 2588.8 2648.8 2664.2 2666.2 2668.9 470.8 471.3 473.1 477.5 484.9 449.3 499.5 510.8 522.6 538.6 6818.2 6894.6 6982.0 8287.8 8367.9 583.9 588.8 590.4 608.7 610.9 3563.0 3626.7 3674.9 3750.0 3823.3 49987.3 51936.7 52315.7 58100.4 63051.7 53909.7 55948.7 56360.7 56372.2 57094.1 51309.5 52356.7 53137.5 53730.0 54818.7 7774.5 7854.7 7947.4 8084.4 8111.1 26301.3 35279.0 36000.6 36114.5 37558.6 44592.8 45393.3 48261.3 49053.3 51372.0 9689.8 9891.7 9960.9 10106.6 10208.8 11770.8 11966.3 12284.9 12409.6 12612.8 10298.3 10818.5 10998.1 11311.5 11558.8 10633.7 10694.6 11001.1 11296.8 11349.7 10785.8 11612.1 11665.4 11674.7 11870.4 8906.9 9042.8 9256.9 9290.3 9294.7 8842.6 9401.4 9424.3 9429.3 9564.6 12:41:52 INFO - PROCESS | 3445 | -------- Summary: end -------- 12:41:52 INFO - PROCESS | 3445 | 12:41:53 INFO - TEST-INFO | 3445: exit 0 12:41:53 INFO - TEST-OK | dromaeo_css | took 1121938ms 12:41:53 INFO - TEST-START | kraken 12:41:53 INFO - operating with platform_type : linux_ 12:41:53 INFO - Initialising browser for kraken test... 12:41:53 INFO - TEST-INFO | started process 3799 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaygZ6x/profile http://localhost:38602/getInfo.html) 12:41:58 INFO - PROCESS | 3799 | __metrics Screen width/height:1600/1200 12:41:58 INFO - PROCESS | 3799 | colorDepth:24 12:41:58 INFO - PROCESS | 3799 | Browser inner width/height: 1024/697 12:41:58 INFO - PROCESS | 3799 | __metrics 12:41:59 ERROR - PROCESS | 3799 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 12:42:00 INFO - TEST-INFO | 3799: exit 0 12:42:00 INFO - Browser initialized. 12:42:00 INFO - Running cycle 1/1 for kraken test... 12:42:00 INFO - TEST-INFO | started process 3920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaygZ6x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:42:12 INFO - PROCESS | 3920 | RSS: Main: 187707392 12:42:12 INFO - PROCESS | 3920 | 12:42:15 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:38602/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38602/tests/kraken/driver.html?testName=audio-beat-detection) 12:42:16 INFO - PROCESS | 3920 | RSS: Main: 200286208 12:42:16 INFO - PROCESS | 3920 | 12:42:19 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:38602/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38602/tests/kraken/driver.html?testName=audio-dft) 12:42:20 INFO - PROCESS | 3920 | RSS: Main: 198221824 12:42:20 INFO - PROCESS | 3920 | 12:42:23 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:38602/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38602/tests/kraken/driver.html?testName=audio-fft) 12:42:23 INFO - PROCESS | 3920 | RSS: Main: 194891776 12:42:23 INFO - PROCESS | 3920 | 12:42:26 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:38602/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38602/tests/kraken/driver.html?testName=audio-oscillator) 12:42:26 INFO - PROCESS | 3920 | RSS: Main: 195248128 12:42:26 INFO - PROCESS | 3920 | 12:42:28 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:38602/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38602/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:42:29 INFO - PROCESS | 3920 | RSS: Main: 195657728 12:42:29 INFO - PROCESS | 3920 | 12:42:32 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:38602/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38602/tests/kraken/driver.html?testName=imaging-darkroom) 12:42:33 INFO - PROCESS | 3920 | RSS: Main: 201314304 12:42:33 INFO - PROCESS | 3920 | 12:42:36 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:38602/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38602/tests/kraken/driver.html?testName=imaging-desaturate) 12:42:37 INFO - PROCESS | 3920 | RSS: Main: 196661248 12:42:37 INFO - PROCESS | 3920 | 12:42:40 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:38602/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38602/tests/kraken/driver.html?testName=json-parse-financial) 12:42:41 INFO - PROCESS | 3920 | RSS: Main: 198090752 12:42:41 INFO - PROCESS | 3920 | 12:42:42 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:38602/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38602/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:42:43 INFO - PROCESS | 3920 | RSS: Main: 198508544 12:42:43 INFO - PROCESS | 3920 | 12:42:45 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:38602/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38602/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:42:45 INFO - PROCESS | 3920 | RSS: Main: 198610944 12:42:45 INFO - PROCESS | 3920 | 12:42:48 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:38602/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38602/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:42:48 INFO - PROCESS | 3920 | RSS: Main: 198848512 12:42:48 INFO - PROCESS | 3920 | 12:42:51 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:38602/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38602/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:42:52 INFO - PROCESS | 3920 | RSS: Main: 199106560 12:42:52 INFO - PROCESS | 3920 | 12:42:55 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:38602/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38602/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:42:56 INFO - PROCESS | 3920 | RSS: Main: 199127040 12:42:56 INFO - PROCESS | 3920 | 12:42:58 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:38602/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38602/tests/kraken/driver.html?testName=ai-astar) 12:42:58 INFO - PROCESS | 3920 | RSS: Main: 201740288 12:42:58 INFO - PROCESS | 3920 | 12:42:58 INFO - PROCESS | 3920 | __start_tp_report 12:42:58 INFO - PROCESS | 3920 | _x_x_mozilla_page_load 12:42:58 INFO - PROCESS | 3920 | _x_x_mozilla_page_load_details 12:42:58 INFO - PROCESS | 3920 | |i|pagename|runs| 12:42:58 INFO - PROCESS | 3920 | |0;ai-astar;110;116;118;117;119;119;118;118;116;116 12:42:58 INFO - PROCESS | 3920 | |1;audio-beat-detection;163;137;139;180;134;132;132;131;168;132 12:42:58 INFO - PROCESS | 3920 | |2;audio-dft;177;164;162;163;162;162;161;164;163;162 12:42:58 INFO - PROCESS | 3920 | |3;audio-fft;77;78;76;116;76;77;76;76;106;77 12:42:58 INFO - PROCESS | 3920 | |4;audio-oscillator;84;83;109;83;83;84;101;85;84;122 12:42:58 INFO - PROCESS | 3920 | |5;imaging-gaussian-blur;118;118;120;119;120;120;118;118;117;118 12:42:58 INFO - PROCESS | 3920 | |6;imaging-darkroom;148;148;149;149;147;148;149;149;149;149 12:42:58 INFO - PROCESS | 3920 | |7;imaging-desaturate;96;96;98;95;100;101;96;97;95;96 12:42:58 INFO - PROCESS | 3920 | |8;json-parse-financial;67;68;66;67;68;67;68;67;68;68 12:42:58 INFO - PROCESS | 3920 | |9;json-stringify-tinderbox;67;66;65;66;66;67;66;65;66;65 12:42:58 INFO - PROCESS | 3920 | |10;stanford-crypto-aes;85;93;86;86;93;87;86;86;87;89 12:42:58 INFO - PROCESS | 3920 | |11;stanford-crypto-ccm;153;154;147;146;160;154;165;152;192;143 12:42:58 INFO - PROCESS | 3920 | |12;stanford-crypto-pbkdf2;184;189;193;184;185;182;180;183;182;188 12:42:58 INFO - PROCESS | 3920 | |13;stanford-crypto-sha256-iterative;75;73;74;70;71;73;70;71;73;72 12:42:58 INFO - PROCESS | 3920 | __end_tp_report 12:42:58 INFO - PROCESS | 3920 | __start_cc_report 12:42:58 INFO - PROCESS | 3920 | _x_x_mozilla_cycle_collect,876 12:42:58 INFO - PROCESS | 3920 | __end_cc_report 12:42:58 INFO - PROCESS | 3920 | __startTimestamp1479501778316__endTimestamp 12:42:58 INFO - PROCESS | 3920 | 12:42:58 INFO - PROCESS | 3920 | ------- Summary: start ------- 12:42:58 INFO - PROCESS | 3920 | Number of tests: 14 12:42:58 INFO - PROCESS | 3920 | 12:42:58 INFO - PROCESS | 3920 | [#0] ai-astar Cycles:10 Average:116.70 Median:118.00 stddev:2.63 (2.2%) stddev-sans-first:1.24 12:42:58 INFO - PROCESS | 3920 | Values: 110.0 116.0 118.0 117.0 119.0 119.0 118.0 118.0 116.0 116.0 12:42:58 INFO - PROCESS | 3920 | 12:42:58 INFO - PROCESS | 3920 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:138.00 stddev:18.26 (13.2%) stddev-sans-first:18.14 12:42:58 INFO - PROCESS | 3920 | Values: 163.0 137.0 139.0 180.0 134.0 132.0 132.0 131.0 168.0 132.0 12:42:58 INFO - PROCESS | 3920 | 12:42:58 INFO - PROCESS | 3920 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:4.67 (2.9%) stddev-sans-first:1.01 12:42:58 INFO - PROCESS | 3920 | Values: 177.0 164.0 162.0 163.0 162.0 162.0 161.0 164.0 163.0 162.0 12:42:58 INFO - PROCESS | 3920 | 12:42:58 INFO - PROCESS | 3920 | [#3] audio-fft Cycles:10 Average:83.50 Median:76.50 stddev:14.70 (19.2%) stddev-sans-first:15.40 12:42:58 INFO - PROCESS | 3920 | Values: 77.0 78.0 76.0 116.0 76.0 77.0 76.0 76.0 106.0 77.0 12:42:58 INFO - PROCESS | 3920 | 12:42:58 INFO - PROCESS | 3920 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:83.50 stddev:13.96 (16.7%) stddev-sans-first:14.52 12:42:58 INFO - PROCESS | 3920 | Values: 84.0 83.0 109.0 83.0 83.0 84.0 101.0 85.0 84.0 122.0 12:42:58 INFO - PROCESS | 3920 | 12:42:58 INFO - PROCESS | 3920 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:118.50 stddev:1.07 (0.9%) stddev-sans-first:1.12 12:42:58 INFO - PROCESS | 3920 | Values: 118.0 118.0 120.0 119.0 120.0 120.0 118.0 118.0 117.0 118.0 12:42:58 INFO - PROCESS | 3920 | 12:42:58 INFO - PROCESS | 3920 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 12:42:58 INFO - PROCESS | 3920 | Values: 148.0 148.0 149.0 149.0 147.0 148.0 149.0 149.0 149.0 149.0 12:42:58 INFO - PROCESS | 3920 | 12:42:58 INFO - PROCESS | 3920 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:96.00 stddev:2.05 (2.1%) stddev-sans-first:2.15 12:42:58 INFO - PROCESS | 3920 | Values: 96.0 96.0 98.0 95.0 100.0 101.0 96.0 97.0 95.0 96.0 12:42:58 INFO - PROCESS | 3920 | 12:42:58 INFO - PROCESS | 3920 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 12:42:58 INFO - PROCESS | 3920 | Values: 67.0 68.0 66.0 67.0 68.0 67.0 68.0 67.0 68.0 68.0 12:42:58 INFO - PROCESS | 3920 | 12:42:58 INFO - PROCESS | 3920 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 12:42:58 INFO - PROCESS | 3920 | Values: 67.0 66.0 65.0 66.0 66.0 67.0 66.0 65.0 66.0 65.0 12:42:58 INFO - PROCESS | 3920 | 12:42:58 INFO - PROCESS | 3920 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:87.00 stddev:2.94 (3.4%) stddev-sans-first:2.93 12:42:58 INFO - PROCESS | 3920 | Values: 85.0 93.0 86.0 86.0 93.0 87.0 86.0 86.0 87.0 89.0 12:42:58 INFO - PROCESS | 3920 | 12:42:58 INFO - PROCESS | 3920 | [#11] stanford-crypto-ccm Cycles:10 Average:156.60 Median:154.00 stddev:14.03 (9.1%) stddev-sans-first:14.82 12:42:58 INFO - PROCESS | 3920 | Values: 153.0 154.0 147.0 146.0 160.0 154.0 165.0 152.0 192.0 143.0 12:42:58 INFO - PROCESS | 3920 | 12:42:58 INFO - PROCESS | 3920 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.00 Median:184.50 stddev:3.92 (2.1%) stddev-sans-first:4.14 12:42:58 INFO - PROCESS | 3920 | Values: 184.0 189.0 193.0 184.0 185.0 182.0 180.0 183.0 182.0 188.0 12:42:58 INFO - PROCESS | 3920 | 12:42:58 INFO - PROCESS | 3920 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:73.00 stddev:1.69 (2.3%) stddev-sans-first:1.45 12:42:58 INFO - PROCESS | 3920 | Values: 75.0 73.0 74.0 70.0 71.0 73.0 70.0 71.0 73.0 72.0 12:42:58 INFO - PROCESS | 3920 | -------- Summary: end -------- 12:42:58 INFO - PROCESS | 3920 | 12:42:59 INFO - TEST-INFO | 3920: exit 0 12:42:59 INFO - TEST-OK | kraken | took 65767ms 12:42:59 INFO - SUITE-END | took 1187s 12:42:59 INFO - Completed test suite (00:19:48) 12:42:59 INFO - javascript benchmark 12:43:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 5959.408345858988, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2541.8220724549283, 2564.705058918225, 2570.07477308169, 2592.131635901973, 2592.7407259274064, 4430.534793846648, 4503.684742068052, 4512.729236245827, 4514.210013247681, 4529.8188072477105, 4466.82132714691, 4486.327050942352, 4564.9543504564945, 4581.1753884300815, 4593.448786145667, 4119.5880411958715, 4146.751194928306, 4195.895102622444, 4225.640820530259, 4269.50900646425, 4187.350960601112, 4236.0468894498645, 4258.9148217035645, 4267.573242675739, 4309.159713855799, 4115.403266526367, 4154.626083652486, 4162.666986641061, 4185.832566697329, 4227.429297044921, 4149.522804877417, 4162.084341444877, 4169.353750168729, 4198.160367926396, 4202.054537729017, 4130.772807495587, 4131.938020929689, 4137.296659567881, 4147.958520414787, 4155.044339801832, 4423.049044455425, 4458.71018383804, 4463.531329210418, 4472.642188624902, 4478.350639157336, 4761.452432970218, 4765.737884416356, 4766.475687674353, 4774.8567542973415, 4779.402574678165, 4763.54746299101, 4821.4696383397795, 4824.107540105092, 4828.73441960692, 4828.975855120702, 4488.932666010012, 4497.325401189848, 4521.59305662492, 4557.931631025537, 4573.862784116482, 4856.771546508822, 4885.6335774817035, 4893.437254715754, 4911.165101932608, 4918.8770280743265, 4601.102784956901, 4602.1025899949855, 4737.028909073631, 4746.786394612251, 4778.928316075262, 4750.239961606127, 4751.216049351888, 4753.453352864465, 4756.096341695067, 4827.348307978378, 4811.398575178103, 4818.566329030404, 4819.566239038503, 4828.275758636232, 4854.2233242681705, 4747.359106520645, 4790.640701947368, 4791.401074865642, 4804.687695299865, 4852.708837469763, 3934.6655534279907, 3965.5439624443557, 4028.597140285948, 4034.0, 4071.918561628751, 3510.736694747904, 3531.2054787673083, 3546.2375589248436, 3550.0947258449446, 3584.032311275941, 4245.0, 4248.745075295492, 4249.851255206053, 4281.721688090326, 4281.850135245251, 4672.813087476531, 4854.854354369375, 4857.732824694675, 4865.416150061945, 4932.062908047459, 4164.5210800757695, 4199.475065616798, 4201.516825565038, 4207.179599978036, 4209.768462734518, 4224.302990006676, 4252.744835309892, 4267.594578515036, 4299.742015479019, 4333.349997500401, 4701.811927522861, 4716.410448693913, 4720.0559888022535, 4721.787519561559, 4759.547842954914, 4884.0, 4909.975450122869, 4912.631552633496, 4919.631027672867, 4950.232713929347, 4456.309272062836, 4511.075229577863, 4515.503294637653, 4692.366530518337, 4727.669063165546, 4642.53574642533, 4666.486686464418, 4785.521447855187, 4805.951940480551, 4807.711537307633, 4866.732329721899, 4872.707637541759, 4874.268859671078, 4915.729634870117, 4922.040202160688, 4706.317583950239, 4719.716816990992, 4805.5915247204375, 4806.903861922672, 4841.515848415272, 4568.269076947672, 4623.630109591292, 4647.209974304444, 4659.743714095757, 4795.760211989456, 4566.908661826811, 4576.496585375539, 4616.653750968758, 4701.670883038155, 4714.457837348748, 4806.567408933212, 4814.735189564608, 4816.831410900601, 4853.830115945925, 4860.489648586848, 4624.075184962953, 4666.78999445019, 4693.718376897397, 4704.3649107370065, 4724.456687480983], "value": 4444.919185058654, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.5322842512801, 549.3490214096296, 551.845483264686, 561.3376216065046, 561.5816216918396, 36720.44919326209, 38110.99999999996, 38495.80752096239, 42385.57614423855, 42411.0, 39144.608553914455, 39480.60519394805, 39714.40428393569, 39748.60251397485, 39850.60149398512, 7518.699252029926, 7715.575643339614, 7715.884261736079, 7717.2668596483245, 7728.420368472387, 7568.016157899493, 7644.082710074799, 7648.273414025659, 7658.315170662446, 7665.770026899174, 7652.1582625911105, 7690.807729806772, 7708.30625243728, 7713.267239612228, 7721.03487064117, 7647.847043059135, 7680.308772210472, 7682.347000504964, 7696.807579810494, 7710.113336966265, 7552.207018263058, 7612.314891659722, 7619.5809230492305, 7627.771166865003, 7631.313181813608, 36463.63536364656, 36815.07962300937, 36833.26333473343, 36862.0, 36901.26197476035, 3004.309008927959, 3030.5605687175234, 3155.952660710091, 3207.5990501187352, 3332.3335332933266, 27305.72694273052, 27584.862075689693, 27658.723412765816, 27972.0, 28608.427831443463, 3433.3476639438677, 3478.5477887874413, 3515.2793677296095, 3543.114221444639, 3692.1692619160476, 169173.0, 169667.0, 169899.0, 170549.99999999875, 170678.0, 49306.75346623244, 49540.0, 49588.752056239486, 49743.0, 49746.0, 52259.73870130625, 52454.73772631113, 52465.7376713114, 52536.0, 52622.47377526252, 12385.256884586954, 12469.127161098817, 12471.438785254686, 12493.750124997448, 12571.622851314476, 9256.7685807854, 9261.0, 9294.814103717888, 9314.394564353295, 9341.2994025447, 14729.189894555902, 14736.778948315783, 14844.0, 15029.774553381709, 15188.544343669708, 5841.211436456109, 5861.443162899518, 5918.201042859159, 6019.358288235642, 6071.119687645355, 774.8372841703193, 793.4287313134533, 865.2083343740533, 967.2165545907837, 977.8705595037743, 25720.485590288088, 27346.069639804235, 27481.17556473309, 27768.58347124795, 27835.860820695765, 924.2236521322121, 925.3106435705442, 929.6002718830832, 939.5865819039601, 986.1617625018677, 14591.0, 14621.26893655313, 14745.618698851702, 14811.333489992976, 14847.554573362817, 353309.0, 354260.0, 355746.0, 356230.0, 357460.0, 48185.277220841715, 48336.0, 48527.27209091866, 48535.5146448531, 48852.0, 1130.5647325779635, 1159.3855256713955, 1180.2151569206553, 1188.714708469961, 1189.6847335456112, 25352.619710704723, 26238.34404139912, 26761.866190668923, 26972.0, 27147.321316967234, 41257.58742412658, 42304.0, 42315.788421057696, 42335.0, 42391.7880410596, 320905.0, 323067.0, 323329.0, 323383.0, 324226.0, 23038.308850734506, 23387.883060584587, 23397.88301058484, 23404.6489302664, 23493.17773877906, 39912.0, 40136.0, 40292.19415611613, 40842.59157408507, 41325.1734965293, 34119.82940085284, 34517.65482345144, 34540.82729586336, 34662.30675386428, 34856.65143348534, 33303.66696333102, 34074.0, 34076.82961585176, 34323.0, 34464.65535344614, 33473.83263083669, 33999.32001359909, 34075.48886766651, 34186.65813341835, 34501.827490862386, 30257.09228723142, 31711.841440792647, 31910.202244944063, 32027.0, 32211.516827247142, 24314.51370972606, 24761.504769904863, 24884.875575622005, 25050.37374065663, 25133.0], "value": 16603.710786158845, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.6225821434456, 337.44102247616013, 345.44211099074994, 346.7208896838047, 356.13281659159946, 13800.86199138007, 15390.0, 15988.920055399707, 16121.758173627404, 16684.165791710428, 16238.350465981346, 16500.0, 16732.079735614538, 16743.916280418613, 16766.07786571738, 4790.80836766529, 4862.319275301461, 5020.196768517038, 5040.722760248185, 5046.293518907356, 4933.062718083571, 4983.277424773406, 5002.0, 5032.320636714052, 5045.848624541251, 5000.099982003256, 5011.899762004758, 5558.110702287635, 5855.297364316288, 5897.587168898179, 5870.383609720981, 5907.763689452417, 5922.970385148046, 5926.792562260343, 5931.822045338647, 5045.672031317989, 5207.505286997767, 5260.1583746600745, 5262.947370526323, 5264.947350526484, 11368.488418021127, 11543.711407214803, 11592.188546801728, 15656.295466704025, 19395.418137455898, 1815.3374018483291, 1919.3090487424515, 1948.366780796247, 2101.4536220582604, 2367.3963139399516, 8263.55661881974, 8535.402521823475, 8847.955760221157, 9010.459372437675, 9081.455112693193, 1669.2571805546536, 1727.904965226912, 1755.4996825904684, 1764.1179410294853, 1766.938157164506, 66010.99999999952, 67208.0, 68096.6595167021, 69463.65268173677, 70786.64606676933, 9476.289278304155, 9505.382150160218, 9644.0, 9801.11789938909, 9866.80266394668, 12995.415206315738, 13005.349732513336, 13021.544245951347, 13035.608931732064, 13050.347482625832, 6462.676866156673, 6620.585697710197, 6636.469082473391, 6673.132492776005, 6704.195496540447, 6132.049532322497, 6140.4473597376455, 6186.412290832363, 6337.651429171347, 6354.3010268870385, 4090.5295890972325, 4107.096438783463, 4114.814833332507, 4132.760171948404, 4219.936700949488, 1714.7856517935259, 1716.7253239481622, 1731.6363563651773, 1732.3157352845556, 1749.9212535435936, 725.9600721960237, 743.695085015152, 758.4349659503595, 779.1273773373857, 883.4610887358706, 15177.848221517865, 15573.299201535958, 16049.438269660506, 16258.75611865823, 16632.50102496927, 781.4686013510753, 782.5617654113714, 786.7600381883581, 791.8257983243677, 820.4912953968578, 8469.788255293544, 8702.0, 8813.91186088131, 9057.909420905838, 9219.124183202584, 361493.0, 362688.0, 373465.0, 376395.95050618675, 378327.0, 46405.76797115993, 47200.0, 56254.71872640611, 75695.62152189204, 78023.2197678016, 859.3855393393753, 892.2638822971074, 896.4979611417497, 896.5114012863005, 898.1557336104041, 12036.0, 14408.42366305378, 14702.117872927658, 14926.925365373103, 15414.152221627917, 36513.087172820895, 36699.26601468009, 36995.815020924725, 37025.629743702215, 37072.44391334078, 47247.52752472569, 49647.25529117139, 51373.74313128411, 57383.713081436, 57405.13892291536, 6849.452043836382, 7192.604406757679, 7286.052813134259, 7286.089238845145, 7456.47804653669, 7371.41028717712, 7945.523268603903, 8007.519548827089, 8106.392020598597, 10878.456077196266, 4385.298352263622, 6955.478339124485, 6999.860002800017, 7453.0, 7604.8479030420185, 6954.721811127498, 7155.105611798525, 7261.056062711814, 7336.339729424378, 7398.186199518156, 7164.360620439386, 7322.926770732224, 7395.223501532261, 7423.294786995227, 7790.298873101221, 10775.784484310114, 11068.667939961813, 11206.7758644825, 11258.38078905668, 11511.0, 10823.67528974132, 10913.727156821144, 10914.781704366027, 11147.88852111501, 11249.71875703114], "value": 7604.889548943883, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.3875617216083, 1372.3069849725887, 1427.0, 1569.0, 1630.0952971101042, 5990.371011043843, 6192.318844927055, 6419.518536109793, 6978.755743548977, 6987.2663370346145, 6477.935220647792, 6713.160854893138, 6715.8656826863435, 6821.795346139611, 6834.863302733942, 2038.8980550972467, 2071.4510654676524, 2076.7923207679264, 2078.4699901525164, 2081.864678795881, 1875.39049808812, 1895.7440745499318, 1903.3148066695978, 1913.8277555020045, 1921.567647279365, 2003.168684995725, 2010.1155491583656, 2017.3040301096098, 2024.6659301215282, 2030.5431277962414, 2019.656658368081, 2040.2757021257462, 2043.0601923115385, 2044.7955204479433, 2047.5802460495563, 2020.6362854686151, 2042.9489262768402, 2046.723692301535, 2049.92825251117, 2061.7835127311714, 6710.295418981034, 6730.596164230113, 6746.156730408699, 6848.452123830081, 6859.55412898165, 4003.4195041718785, 4124.670026397881, 4139.668826493873, 4140.213359461723, 4141.295979683461, 2650.2314328844614, 2743.629610002644, 2778.749912507884, 2791.204506715597, 2807.536756435186, 871.6121326009928, 901.2969883490888, 918.091089821079, 920.1442658327752, 935.5930170375908, 8644.35167362444, 8665.610047547812, 8710.433821801626, 8712.738617841474, 8766.736997890073, 3500.493746686024, 3594.4248920172645, 3644.6902013328636, 3655.1227705351057, 3711.9072023199637, 7650.38796896247, 7678.616069196518, 7701.0, 7728.420368472387, 7729.497582657109, 4180.707350485498, 4201.894952626148, 4206.053637931502, 4209.095044565433, 4211.789410529523, 3387.796732196076, 3491.0574144980715, 3684.1894783147663, 3759.6992240620684, 3822.6177382261553, 3223.9838800805846, 3232.3858466891215, 3349.681780230874, 3362.00820757877, 3375.4261775498226, 1073.6058589345803, 1085.6634443322596, 1090.1987039525943, 1091.5197313182175, 1094.6770702642739, 707.6355676826438, 833.4207725630629, 835.1856939483954, 842.2293601354814, 846.6655671009917, 4701.294805779161, 4797.18447863864, 4803.879903002383, 4861.586765124934, 5056.089903817275, 384.4579143407782, 390.6171951487558, 391.6083916083916, 393.0547034382315, 395.4305799648497, 3314.303996160785, 3344.364570731553, 3355.194753259249, 3383.7293016558615, 3439.5872495300723, 7478.401727861867, 7691.5769632670745, 7822.530648161129, 7831.960840195877, 7840.882386764203, 7613.5431874087735, 7754.108277548155, 7797.103333116651, 7799.181085986003, 7828.686852525835, 6170.259568851677, 6221.813345599639, 6243.687815609202, 6248.500119990481, 6263.498920086382, 4726.692764970266, 4745.738984355894, 4776.880577985439, 4791.736454495036, 4864.464908860094, 7035.648217589202, 7159.248278930846, 7220.205777364591, 7251.23861994483, 7308.524945878501, 7404.259574042552, 7435.182129965591, 7480.401567874448, 7481.064866891638, 7542.245775422414, 5816.883662326645, 5937.495312898452, 5940.227770389822, 5955.970220148872, 6067.635941843503, 6501.837454063686, 6617.470602351897, 6623.437007854193, 6627.734890604322, 6627.867442651216, 5953.345132035559, 6000.429959153874, 6125.111858780541, 6135.907961380493, 6161.106639537153, 5877.617954832922, 5922.881542369215, 5936.614120082181, 5939.703014849327, 5949.077892926603, 5543.695096769717, 5546.362168350692, 5558.610897237155, 5562.9721851392105, 5602.915956260578, 3929.4498770172772, 4032.9596704032583, 4137.8965525862095, 4150.418941348274, 4187.58124187591, 4215.367694845675, 4221.767802770877, 4277.550857160078, 4309.116631090556, 4360.040791025969], "value": 3624.061676753722, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.6678202765667, 284.63234159861867, 287.05987889661355, 289.73199790194076, 290.81782553918305, 4712.269598212274, 4798.752324395656, 4842.322074909511, 4844.854654360366, 4895.779689913954, 4769.737664428455, 4787.928181077286, 4793.281007848825, 4799.328094066834, 4808.687435316702, 3597.172650290435, 3701.444783282502, 3704.851805927773, 3707.8876337098895, 3735.5345471988426, 3694.242680250542, 3706.3328600851837, 3717.2379662169324, 3730.5150330457004, 3731.2910546995986, 3638.1268495561008, 3675.9632403675887, 3676.963230367689, 3695.6858667013203, 3699.075231192202, 3684.373656478405, 3706.5552133743854, 3710.5732840723394, 3715.8885233442907, 3725.4598083278042, 2969.85150742462, 3084.629844418662, 3116.750659947199, 3143.6227652681596, 3149.3071524264624, 4617.8152873885, 4655.604273636745, 4656.627469802408, 4678.836240731592, 4682.157211701892, 4074.9185016299803, 4076.490438695163, 4098.446709694183, 4102.466679331697, 4127.545969943304, 4792.18532849413, 4895.485973972753, 4902.534259245366, 4941.950580494185, 5000.374953130859, 3435.055359776057, 3444.207832198583, 3453.1698199954067, 3469.670381313771, 3473.3574288756663, 5158.716270605115, 5160.870978225575, 5163.561097306771, 5172.741362931838, 5196.68819870809, 3510.596281427617, 3512.24486735348, 3540.0, 3555.822208889545, 3557.94663080054, 3503.3343664703625, 3576.8211589420425, 3584.9103772405897, 3585.964140358563, 3588.1926566522325, 4078.490188726409, 4090.856820011345, 4103.363978583325, 4116.300228961084, 4120.896977575585, 4893.996730670276, 4908.950910490849, 4927.77824997876, 4940.752962351868, 5024.57291130258, 1167.854018247719, 1199.322382853685, 1210.3766560221493, 1214.5384753793503, 1215.1858254969193, 802.2699343597299, 814.8795406316315, 816.8284660221301, 818.9549574773325, 819.148085990575, 4272.073629563759, 4286.357046443059, 4316.525182229952, 4320.567943205654, 4386.18855511725, 5114.105031619526, 5122.335241046675, 5137.40919794221, 5139.280500729901, 5158.845234642967, 4403.119376124788, 4421.845235416745, 4492.932606010912, 4502.752348620792, 4512.842050528216, 2597.6752905886765, 2646.287555255878, 2668.5196664600558, 2676.487784401807, 2697.5414179589516, 4815.686980346336, 4821.035792841446, 4823.14308991041, 4859.975700121477, 4869.269609558594, 5063.733891639945, 5091.5123140648775, 5133.922991155136, 5138.845834624967, 5146.228065790161, 4639.584926597353, 4759.785809638505, 4781.95218047822, 4790.568848803624, 4794.232922732485, 4974.278729584118, 4988.725620090785, 5017.297578338962, 5021.372328458942, 5022.648414611088, 4879.585235255043, 4899.681520701143, 4902.700784292237, 4905.969746353163, 4907.337509436323, 4581.885452863705, 4809.893724443327, 4829.27560865873, 4849.75751212445, 4858.5384388483035, 3463.1169051891607, 3475.878344257939, 3476.5654293213347, 3491.336646037245, 3497.5199676322222, 5008.348914641073, 5022.974885125551, 5032.194848824171, 5046.21783623539, 5062.417821950523, 4629.837955671535, 4864.805407783649, 4918.6065114791445, 4918.950810491992, 4945.727984960861, 4839.370881785346, 4848.9757551212015, 4859.979404325131, 4860.465348811557, 4873.390826146731, 4745.979614382924, 4760.761961901961, 4813.785658596945, 4820.842997680602, 4835.637327200544, 4735.266033764772, 4893.9021219576125, 4899.755012249445, 4917.6311776616185, 4927.876803079952, 4771.731364015661, 4785.330053792402, 4785.473597904158, 4786.282057691375, 4811.3264143019305], "value": 3693.8622349606408, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.6742675241993, 627.272364057693, 650.6746626686656, 719.5287086958041, 737.8671839068969, 11781.410929453525, 12223.633291001262, 12483.687907802287, 12506.874931250673, 12572.685682857933, 11934.104942129354, 11979.341136237503, 11993.340366279852, 12005.279683219012, 12100.27398356097, 739.8261408568982, 773.2924374197603, 781.7342103684746, 782.7612578163686, 783.0094929913636, 744.13680131048, 754.3098065270271, 780.3328154427968, 781.3749000799338, 783.7296132834163, 813.7314686153585, 814.2346194577108, 814.6252723747084, 815.759350991459, 817.7628487738549, 800.8478389106081, 801.5511313664338, 802.6468353924283, 802.7391097893208, 803.4656953126164, 592.4726992976255, 592.5378205000106, 592.6325678079618, 592.937741537141, 593.0274350065895, 12447.0, 12455.439505222286, 12477.376131193494, 12479.688007799787, 12552.121351505399, 11054.889451105546, 11120.221584489089, 11228.438578071064, 11594.246373985749, 11836.289822610672, 10795.46022698862, 10919.39943303118, 11035.83446248299, 11052.0, 11387.202895797298, 3988.8205030773684, 3989.4614227079264, 4015.9196816063513, 4027.07377303219, 4063.1061166543313, 46774.766126169154, 48081.75959120217, 48700.512994869954, 49448.50551494475, 49832.252516212284, 9392.765180870396, 9443.480608566457, 9607.327487075978, 9681.37071090377, 9749.707508774749, 16266.186690665656, 16286.0, 16354.427595034116, 16408.917955410147, 16411.91794041022, 6319.46284565817, 6413.6793160341795, 6417.903731444032, 6443.29123796382, 6693.364130407604, 3453.8963831085107, 3547.095490649919, 3593.6047034826147, 3658.158623516606, 3683.5027271318563, 2588.818782685194, 2648.7880969522394, 2664.160789351387, 2666.1734862192784, 2668.8799004044863, 470.7528547512515, 471.29541335703345, 473.1365258403359, 477.49147158276327, 484.8739327774804, 449.2833929881833, 499.49301459019125, 510.81610620176707, 522.6048928511202, 538.5825984861764, 6818.2159051708695, 6894.620795856175, 6981.965090174618, 8287.751367458986, 8367.874481882776, 583.8744669895992, 588.8174665853599, 590.447931184344, 608.6834845880206, 610.91141784441, 3562.964370356315, 3626.673599376069, 3674.9081272968388, 3749.9812500937865, 3823.311803875329, 49987.25019124716, 51936.740316298936, 52315.73842130765, 58100.418995810345, 63051.684741576, 53909.730451347496, 55948.72025639927, 56360.71819640876, 56372.15441768377, 57094.143587846214, 51309.48690513047, 52356.73821630867, 53137.46862531325, 53730.0, 54818.725906370215, 7774.455788094779, 7854.72508462201, 7947.364210863233, 8084.39367047462, 8111.107778144517, 26301.34246643849, 35279.0, 36000.63999360077, 36114.45828312525, 37558.62441375551, 44592.77703611591, 45393.319100212866, 48261.276080858115, 49053.264201037724, 51372.0, 9689.806203876024, 9891.653792117242, 9960.900390996287, 10106.646267380607, 10208.846867297145, 11770.76458470843, 11966.341851198267, 12284.938575307066, 12409.565665201675, 12612.810807838074, 10298.279120461795, 10818.459077045958, 10998.12015038779, 11311.490982905954, 11558.826617600575, 10633.734156646145, 10694.572217111228, 11001.064909482784, 11296.774064518499, 11349.716257093638, 10785.838212426977, 11612.129090318429, 11665.416729163677, 11674.70813229676, 11870.406479675808, 8906.86639700392, 9042.773930651787, 9256.861147082664, 9290.349675522648, 9294.72115836526, 8842.557872106498, 9401.388909720847, 9424.340296179202, 9429.292803039662, 9564.56959436841], "value": 5961.1039065491195, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1599.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 116.0, 118.0, 117.0, 119.0, 119.0, 118.0, 118.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 137.0, 139.0, 180.0, 134.0, 132.0, 132.0, 131.0, 168.0, 132.0], "value": 144.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 164.0, 162.0, 163.0, 162.0, 162.0, 161.0, 164.0, 163.0, 162.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 76.0, 116.0, 76.0, 77.0, 76.0, 76.0, 106.0, 77.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 109.0, 83.0, 83.0, 84.0, 101.0, 85.0, 84.0, 122.0], "value": 91.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 120.0, 119.0, 120.0, 120.0, 118.0, 118.0, 117.0, 118.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 149.0, 147.0, 148.0, 149.0, 149.0, 149.0, 149.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 98.0, 95.0, 100.0, 101.0, 96.0, 97.0, 95.0, 96.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 67.0, 68.0, 67.0, 68.0, 67.0, 68.0, 68.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 66.0, 66.0, 67.0, 66.0, 65.0, 66.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 93.0, 86.0, 86.0, 93.0, 87.0, 86.0, 86.0, 87.0, 89.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 154.0, 147.0, 146.0, 160.0, 154.0, 165.0, 152.0, 192.0, 143.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 189.0, 193.0, 184.0, 185.0, 182.0, 180.0, 183.0, 182.0, 188.0], "value": 185.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 70.0, 71.0, 73.0, 70.0, 71.0, 73.0, 72.0], "value": 72.2, "unit": "score"}]}]} 12:43:00 INFO - Return code: 0 12:43:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:43:00 ERROR - # TBPL SUCCESS # 12:43:00 INFO - Running post-action listener: _resource_record_post_action 12:43:00 INFO - [mozharness: 2016-11-18 20:43:00.116789Z] Finished run-tests step (success) 12:43:00 INFO - Running post-run listener: _resource_record_post_run 12:43:00 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 7892992; Write bytes: 416116736; Read time: 2204; Write time: 387856 12:43:00 INFO - TinderboxPrint: CPU usage
13.5% 12:43:00 INFO - TinderboxPrint: I/O read bytes / time
7,892,992 / 2,204 12:43:00 INFO - TinderboxPrint: I/O write bytes / time
416,116,736 / 387,856 12:43:00 INFO - TinderboxPrint: CPU idle
8,313.9 (86.5%) 12:43:00 INFO - TinderboxPrint: CPU user
1,231.3 (12.8%) 12:43:00 INFO - TinderboxPrint: Swap in / out
0 / 0 12:43:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 11743232; Read time: 0; Write time: 956 12:43:00 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 5709824; Write bytes: 322207744; Read time: 1848; Write time: 312900 12:43:00 INFO - Running post-run listener: _upload_blobber_files 12:43:00 INFO - Blob upload gear active. 12:43:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:43:00 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 12:43:00 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:43:00 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:43:01 INFO - (blobuploader) - INFO - Open directory for files ... 12:43:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:43:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:43:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:43:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:43:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:43:01 INFO - (blobuploader) - INFO - Done attempting. 12:43:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:43:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:43:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:43:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:43:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:43:04 INFO - (blobuploader) - INFO - Done attempting. 12:43:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:43:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:43:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:43:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:43:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:43:05 INFO - (blobuploader) - INFO - Done attempting. 12:43:05 INFO - (blobuploader) - INFO - Iteration through files over. 12:43:05 INFO - Return code: 0 12:43:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:43:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:43:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/79bdc5c7ea169d7c10cea168ae7c86eb4faabf992058da01f7b07755a052bf7cc1b51b1842e749a72c4054898b27ac70adada8d1b2b87a6130470d8403c64588", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3e606a9b57d15ecc71829c3cd1a65b701ee3ec7925a7f3db240bf97fb9b92412eebf813f89dd3807b2bcc78dcb70284c481c5ca209d0b0eef296e602f69f257f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/985754bc687e6e8c1d254311ec311712ec545b57abeceef77b3885e3712105ce9fadf8f7b34eb09f02c2f86ee799d27de14ccddb54c23e7f633eeb922262c15f"} 12:43:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:43:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:43:05 INFO - Contents: 12:43:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/79bdc5c7ea169d7c10cea168ae7c86eb4faabf992058da01f7b07755a052bf7cc1b51b1842e749a72c4054898b27ac70adada8d1b2b87a6130470d8403c64588", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3e606a9b57d15ecc71829c3cd1a65b701ee3ec7925a7f3db240bf97fb9b92412eebf813f89dd3807b2bcc78dcb70284c481c5ca209d0b0eef296e602f69f257f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/985754bc687e6e8c1d254311ec311712ec545b57abeceef77b3885e3712105ce9fadf8f7b34eb09f02c2f86ee799d27de14ccddb54c23e7f633eeb922262c15f"} 12:43:05 INFO - Running post-run listener: copy_logs_to_upload_dir 12:43:05 INFO - Copying logs to upload dir... 12:43:05 INFO - mkdir: /builds/slave/test/build/upload/logs 12:43:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.429054 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-11-18 12:43:05.706366) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 12:43:05.792418) ========= 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=826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/79bdc5c7ea169d7c10cea168ae7c86eb4faabf992058da01f7b07755a052bf7cc1b51b1842e749a72c4054898b27ac70adada8d1b2b87a6130470d8403c64588", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3e606a9b57d15ecc71829c3cd1a65b701ee3ec7925a7f3db240bf97fb9b92412eebf813f89dd3807b2bcc78dcb70284c481c5ca209d0b0eef296e602f69f257f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/985754bc687e6e8c1d254311ec311712ec545b57abeceef77b3885e3712105ce9fadf8f7b34eb09f02c2f86ee799d27de14ccddb54c23e7f633eeb922262c15f"} build_url:https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011145 build_url: 'https://queue.taskcluster.net/v1/task/KPM7GjfrSfGEe5E7iGm8_A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/79bdc5c7ea169d7c10cea168ae7c86eb4faabf992058da01f7b07755a052bf7cc1b51b1842e749a72c4054898b27ac70adada8d1b2b87a6130470d8403c64588", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3e606a9b57d15ecc71829c3cd1a65b701ee3ec7925a7f3db240bf97fb9b92412eebf813f89dd3807b2bcc78dcb70284c481c5ca209d0b0eef296e602f69f257f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/985754bc687e6e8c1d254311ec311712ec545b57abeceef77b3885e3712105ce9fadf8f7b34eb09f02c2f86ee799d27de14ccddb54c23e7f633eeb922262c15f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 12:43:05.818300) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 12:43:05.818678) ========= 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=826874ccc97bd7bf541b4875000001d5-1479497808.853463-455518520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 12:43:05.901292) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 12:43:05.901649) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 12:43:05.901985) ========= ========= Total master_lag: 0.18 =========