builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1478842156.59 results: success (0) buildid: 20161110184015 builduid: d1b3d796a3db48ef9d86f1c168482cff revision: bb7bc01deac5bf711297e216328e640aeb729895 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-10 21:29:16.595001) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-10 21:29:16.595443) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-10 21:29:16.595718) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-10 21:29:16.610306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 21:29:16.610603) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-10 21:29:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 22.8M=0.001s 2016-11-10 21:29:17 (22.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105049 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 21:29:16.731609) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 21:29:16.732192) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017390 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 21:29:16.782558) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 21:29:16.782896) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev bb7bc01deac5bf711297e216328e640aeb729895 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev bb7bc01deac5bf711297e216328e640aeb729895 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-10 21:29:17,372 truncating revision to first 12 chars 2016-11-10 21:29:17,372 Setting DEBUG logging. 2016-11-10 21:29:17,372 attempt 1/10 2016-11-10 21:29:17,372 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/bb7bc01deac5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-10 21:29:17,679 unpacking tar archive at: mozilla-inbound-bb7bc01deac5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.616840 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 21:29:17.413690) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-10 21:29:17.413993) ========= script_repo_revision: bb7bc01deac5bf711297e216328e640aeb729895 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-10 21:29:17.414426) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-10 21:29:17.414739) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-10 21:29:17.424052) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-10 21:29:17.424346) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:29:18 INFO - MultiFileLogger online at 20161110 21:29:18 in /builds/slave/test 21:29:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 21:29:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:29:18 INFO - {'append_to_log': False, 21:29:18 INFO - 'base_work_dir': '/builds/slave/test', 21:29:18 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:29:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:29:18 INFO - 'branch': 'Mozilla-Inbound', 21:29:18 INFO - 'buildbot_json_path': 'buildprops.json', 21:29:18 INFO - 'config_files': ('talos/linux_config.py',), 21:29:18 INFO - 'default_actions': ('clobber', 21:29:18 INFO - 'read-buildbot-config', 21:29:18 INFO - 'download-and-extract', 21:29:18 INFO - 'populate-webroot', 21:29:18 INFO - 'create-virtualenv', 21:29:18 INFO - 'install', 21:29:18 INFO - 'run-tests'), 21:29:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:29:18 INFO - 'download_minidump_stackwalk': True, 21:29:18 INFO - 'download_symbols': 'ondemand', 21:29:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:29:18 INFO - 'tooltool.py': '/tools/tooltool.py', 21:29:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:29:18 INFO - '/tools/misc-python/virtualenv.py')}, 21:29:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:29:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:29:18 INFO - 'installer_path': 'installer.exe', 21:29:18 INFO - 'log_level': 'info', 21:29:18 INFO - 'log_name': 'talos', 21:29:18 INFO - 'log_to_console': True, 21:29:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:29:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:29:18 INFO - 'opt_config_files': (), 21:29:18 INFO - 'pip_index': False, 21:29:18 INFO - 'sps_profile': False, 21:29:18 INFO - 'sps_profile_interval': 0, 21:29:18 INFO - 'suite': 'dromaeojs-e10s', 21:29:18 INFO - 'system_bits': '32', 21:29:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:29:18 INFO - 'title': 'talos-linux64-ix-049', 21:29:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:29:18 INFO - 'use_talos_json': True, 21:29:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:29:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:29:18 INFO - 'work_dir': 'build'} 21:29:18 INFO - [mozharness: 2016-11-11 05:29:18.118587Z] Running clobber step. 21:29:18 INFO - Running pre-action listener: _resource_record_pre_action 21:29:18 INFO - Running main action method: clobber 21:29:18 INFO - rmtree: /builds/slave/test/build 21:29:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:29:18 INFO - Running post-action listener: _resource_record_post_action 21:29:18 INFO - [mozharness: 2016-11-11 05:29:18.581794Z] Finished clobber step (success) 21:29:18 INFO - [mozharness: 2016-11-11 05:29:18.581893Z] Running read-buildbot-config step. 21:29:18 INFO - Running pre-action listener: _resource_record_pre_action 21:29:18 INFO - Running main action method: read_buildbot_config 21:29:18 INFO - Using buildbot properties: 21:29:18 INFO - { 21:29:18 INFO - "project": "", 21:29:18 INFO - "product": "firefox", 21:29:18 INFO - "script_repo_revision": "production", 21:29:18 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 21:29:18 INFO - "repository": "", 21:29:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 21:29:18 INFO - "buildid": "20161110184015", 21:29:18 INFO - "pgo_build": "True", 21:29:18 INFO - "basedir": "/builds/slave/test", 21:29:18 INFO - "buildnumber": 1573, 21:29:18 INFO - "slavename": "talos-linux64-ix-049", 21:29:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:29:18 INFO - "platform": "ubuntu64_hw", 21:29:18 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:29:18 INFO - "branch": "mozilla-inbound", 21:29:18 INFO - "repo_path": "integration/mozilla-inbound", 21:29:18 INFO - "revision": "bb7bc01deac5bf711297e216328e640aeb729895", 21:29:18 INFO - "stage_platform": "linux64-pgo", 21:29:18 INFO - "builduid": "d1b3d796a3db48ef9d86f1c168482cff", 21:29:18 INFO - "slavebuilddir": "test" 21:29:18 INFO - } 21:29:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:29:18 INFO - Running post-action listener: _resource_record_post_action 21:29:18 INFO - [mozharness: 2016-11-11 05:29:18.584548Z] Finished read-buildbot-config step (success) 21:29:18 INFO - [mozharness: 2016-11-11 05:29:18.584636Z] Running download-and-extract step. 21:29:18 INFO - Running pre-action listener: _resource_record_pre_action 21:29:18 INFO - Running main action method: download_and_extract 21:29:18 INFO - mkdir: /builds/slave/test/build/tests 21:29:18 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')]} 21:29:18 INFO - trying https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:29:18 INFO - Downloading https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:29:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:29:19 INFO - Downloaded 1361 bytes. 21:29:19 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:29:19 INFO - Using the following test package requirements: 21:29:19 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:29:19 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:29:19 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:29:19 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:19 INFO - u'jsshell-linux-x86_64.zip'], 21:29:19 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:29:19 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:29:19 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:29:19 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:29:19 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:29:19 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:29:19 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:29:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:29:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:29:19 INFO - Fetch https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:29:19 INFO - Http code: 200 21:29:19 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 21:29:19 INFO - x-amz-cf-id: 5fDifMG_zL2MA3gdnLtBX2f6pdF3Dko9_al9XRzeOmi2Qr4blPK7Pg== 21:29:19 INFO - x-amz-version-id: Fd8BdQIplVJzX57tlAfYg7KKVJSg4HLL 21:29:19 INFO - Expected file size: 21974653 21:29:19 INFO - Obtained file size: 21974653 21:29:24 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:29:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:29:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:29:24 INFO - Fetch https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:29:24 INFO - Http code: 200 21:29:24 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 21:29:24 INFO - x-amz-cf-id: IrKd_BIHhgBxpHIpOc7FrFHm7wDAJz0JLpNJE4V-hvxWlByBstpsng== 21:29:24 INFO - x-amz-version-id: Fd8BdQIplVJzX57tlAfYg7KKVJSg4HLL 21:29:24 INFO - Expected file size: 21974653 21:29:24 INFO - Obtained file size: 21974653 21:29:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:29:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:29:29 INFO - Fetch https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:29:29 INFO - Http code: 200 21:29:29 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 21:29:29 INFO - x-amz-cf-id: bEd1eOFxKrarly4SGn4Ni-ojMzzm5WRdvEoAWUzNPSb4mEIUV_yUOQ== 21:29:29 INFO - x-amz-version-id: oo5eU25khAvcu8lFwgMrW8jYMF0mcoVK 21:29:29 INFO - Expected file size: 14409038 21:29:29 INFO - Obtained file size: 14409038 21:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:30 INFO - trying https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:29:30 INFO - Downloading https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:29:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:29:31 INFO - Downloaded 59266575 bytes. 21:29:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:29:31 INFO - mkdir: /builds/slave/test/properties 21:29:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:29:31 INFO - Writing to file /builds/slave/test/properties/build_url 21:29:31 INFO - Contents: 21:29:31 INFO - build_url:https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:29:32 INFO - Running post-action listener: _resource_record_post_action 21:29:32 INFO - Running post-action listener: set_extra_try_arguments 21:29:32 INFO - [mozharness: 2016-11-11 05:29:32.014828Z] Finished download-and-extract step (success) 21:29:32 INFO - [mozharness: 2016-11-11 05:29:32.015096Z] Running populate-webroot step. 21:29:32 INFO - Running pre-action listener: _resource_record_pre_action 21:29:32 INFO - Running main action method: populate_webroot 21:29:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:29:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:29:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:29:32 INFO - '--tppagecycles', 21:29:32 INFO - '7'], 21:29:32 INFO - 'tests': ['tsvgm']}}, 21:29:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:29:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:29:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:29:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:29:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:29:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:29:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:32 INFO - 'talos_options': ['--disable-e10s'], 21:29:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:29:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:29:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:32 INFO - 'talos_options': ['--disable-e10s'], 21:29:32 INFO - 'tests': ['damp', 'tps']}, 21:29:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:32 INFO - 'tests': ['damp', 'tps']}, 21:29:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:29:32 INFO - 'tests': ['dromaeo_dom']}, 21:29:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:29:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:29:32 INFO - 'tests': ['basic_compositor_video']}, 21:29:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:29:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:29:32 INFO - 'tests': ['a11yr', 21:29:32 INFO - 'ts_paint', 21:29:32 INFO - 'tpaint', 21:29:32 INFO - 'sessionrestore', 21:29:32 INFO - 'sessionrestore_no_auto_restore', 21:29:32 INFO - 'tabpaint']}, 21:29:32 INFO - 'other-e10s': {'tests': ['a11yr', 21:29:32 INFO - 'ts_paint', 21:29:32 INFO - 'tpaint', 21:29:32 INFO - 'sessionrestore', 21:29:32 INFO - 'sessionrestore_no_auto_restore', 21:29:32 INFO - 'tabpaint']}, 21:29:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:29:32 INFO - 'ts_paint', 21:29:32 INFO - 'tpaint', 21:29:32 INFO - 'sessionrestore', 21:29:32 INFO - 'sessionrestore_no_auto_restore', 21:29:32 INFO - 'tabpaint']}, 21:29:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:29:32 INFO - 'ts_paint', 21:29:32 INFO - 'tpaint', 21:29:32 INFO - 'sessionrestore', 21:29:32 INFO - 'sessionrestore_no_auto_restore', 21:29:32 INFO - 'tabpaint']}, 21:29:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:29:32 INFO - 'tests': ['a11yr', 21:29:32 INFO - 'ts_paint', 21:29:32 INFO - 'tpaint', 21:29:32 INFO - 'sessionrestore', 21:29:32 INFO - 'sessionrestore_no_auto_restore', 21:29:32 INFO - 'tabpaint']}, 21:29:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:29:32 INFO - 'tests': ['a11yr', 21:29:32 INFO - 'ts_paint', 21:29:32 INFO - 'tpaint', 21:29:32 INFO - 'sessionrestore', 21:29:32 INFO - 'sessionrestore_no_auto_restore', 21:29:32 INFO - 'tabpaint']}, 21:29:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:29:32 INFO - 'tests': ['tsvgx', 21:29:32 INFO - 'tsvgr_opacity', 21:29:32 INFO - 'tart', 21:29:32 INFO - 'tscrollx', 21:29:32 INFO - 'cart']}, 21:29:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:29:32 INFO - 'tsvgr_opacity', 21:29:32 INFO - 'tart', 21:29:32 INFO - 'tscrollx', 21:29:32 INFO - 'cart']}, 21:29:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:32 INFO - 'talos_options': ['--disable-e10s'], 21:29:32 INFO - 'tests': ['tp5o']}, 21:29:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:32 INFO - 'tests': ['tp5o']}, 21:29:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:32 INFO - 'talos_options': ['--disable-e10s', 21:29:32 INFO - '--xperf_path', 21:29:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:29:32 INFO - 'tests': ['tp5n']}, 21:29:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:32 INFO - 'talos_options': ['--xperf_path', 21:29:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:29:32 INFO - 'tests': ['tp5n']}}, 21:29:32 INFO - 'talos.zip': {'path': '', 21:29:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:29:32 INFO - Running post-action listener: _resource_record_post_action 21:29:32 INFO - [mozharness: 2016-11-11 05:29:32.033214Z] Finished populate-webroot step (success) 21:29:32 INFO - [mozharness: 2016-11-11 05:29:32.033302Z] Running create-virtualenv step. 21:29:32 INFO - Running pre-action listener: _resource_record_pre_action 21:29:32 INFO - Running main action method: create_virtualenv 21:29:32 INFO - Creating virtualenv /builds/slave/test/build/venv 21:29:32 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 21:29:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:29:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:29:32 INFO - Using real prefix '/usr' 21:29:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:29:32 INFO - Installing distribute.............................................................................................................................................................................................done. 21:29:34 INFO - Installing pip.................done. 21:29:34 INFO - Return code: 0 21:29:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:29:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:29:34 INFO - Reading from file tmpfile_stdout 21:29:34 INFO - Output received: 21:29: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) 21:29:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:29: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')]} 21:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29: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')]} 21:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29: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 0x7fe5553bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179af60>, '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 0x179bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907', '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 21:29: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 21:29: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 21:29:34 INFO - Using env: {'DISPLAY': ':0', 21:29:34 INFO - 'HOME': '/home/cltbld', 21:29:34 INFO - 'LANG': 'en_US.UTF-8', 21:29:34 INFO - 'LANGUAGE': 'en_US:en', 21:29:34 INFO - 'LOGNAME': 'cltbld', 21:29:34 INFO - 'MAIL': '/var/mail/cltbld', 21:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:34 INFO - 'MOZ_NO_REMOTE': '1', 21:29:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:34 INFO - 'NO_EM_RESTART': '1', 21:29:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:34 INFO - 'PWD': '/builds/slave/test', 21:29:34 INFO - 'SHELL': '/bin/bash', 21:29:34 INFO - 'SHLVL': '1', 21:29:34 INFO - 'TERM': 'linux', 21:29:34 INFO - 'TMOUT': '86400', 21:29:34 INFO - 'USER': 'cltbld', 21:29:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907', 21:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:34 INFO - '_': '/tools/buildbot/bin/python'} 21:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:35 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 21:29:35 INFO - Cleaning up... 21:29:35 INFO - Return code: 0 21:29:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:29:35 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')]} 21:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:35 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')]} 21:29:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:35 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 0x7fe5553bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179af60>, '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 0x179bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907', '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 21:29:35 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 21:29:35 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 21:29:35 INFO - Using env: {'DISPLAY': ':0', 21:29:35 INFO - 'HOME': '/home/cltbld', 21:29:35 INFO - 'LANG': 'en_US.UTF-8', 21:29:35 INFO - 'LANGUAGE': 'en_US:en', 21:29:35 INFO - 'LOGNAME': 'cltbld', 21:29:35 INFO - 'MAIL': '/var/mail/cltbld', 21:29:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:35 INFO - 'MOZ_NO_REMOTE': '1', 21:29:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:35 INFO - 'NO_EM_RESTART': '1', 21:29:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:35 INFO - 'PWD': '/builds/slave/test', 21:29:35 INFO - 'SHELL': '/bin/bash', 21:29:35 INFO - 'SHLVL': '1', 21:29:35 INFO - 'TERM': 'linux', 21:29:35 INFO - 'TMOUT': '86400', 21:29:35 INFO - 'USER': 'cltbld', 21:29:35 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907', 21:29:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:35 INFO - '_': '/tools/buildbot/bin/python'} 21:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:35 INFO - Downloading/unpacking psutil>=3.1.1 21:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:29:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:29:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:29:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:29:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:29:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:29:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:29:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:29:37 INFO - Installing collected packages: psutil 21:29:37 INFO - Running setup.py install for psutil 21:29:37 INFO - building 'psutil._psutil_linux' extension 21:29:37 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 21:29: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 21:29:37 INFO - building 'psutil._psutil_posix' extension 21:29:37 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 21:29: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:29:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:29:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:29:37 INFO - Successfully installed psutil 21:29:37 INFO - Cleaning up... 21:29:37 INFO - Return code: 0 21:29:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:29:37 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')]} 21:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:37 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')]} 21:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:37 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 0x7fe5553bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179af60>, '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 0x179bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907', '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 21:29:37 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 21:29:37 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 21:29:37 INFO - Using env: {'DISPLAY': ':0', 21:29:37 INFO - 'HOME': '/home/cltbld', 21:29:37 INFO - 'LANG': 'en_US.UTF-8', 21:29:37 INFO - 'LANGUAGE': 'en_US:en', 21:29:37 INFO - 'LOGNAME': 'cltbld', 21:29:37 INFO - 'MAIL': '/var/mail/cltbld', 21:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:37 INFO - 'MOZ_NO_REMOTE': '1', 21:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:37 INFO - 'NO_EM_RESTART': '1', 21:29:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:37 INFO - 'PWD': '/builds/slave/test', 21:29:37 INFO - 'SHELL': '/bin/bash', 21:29:37 INFO - 'SHLVL': '1', 21:29:37 INFO - 'TERM': 'linux', 21:29:37 INFO - 'TMOUT': '86400', 21:29:37 INFO - 'USER': 'cltbld', 21:29:37 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907', 21:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:37 INFO - '_': '/tools/buildbot/bin/python'} 21:29:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:29: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 21:29: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 21:29: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 21:29: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 21:29: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 21:29: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 21:29:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:29:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:29:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:29:40 INFO - Installing collected packages: mozsystemmonitor 21:29:40 INFO - Running setup.py install for mozsystemmonitor 21:29:40 INFO - Successfully installed mozsystemmonitor 21:29:40 INFO - Cleaning up... 21:29:40 INFO - Return code: 0 21:29:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:29: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')]} 21:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29: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')]} 21:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29: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 0x7fe5553bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179af60>, '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 0x179bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907', '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 21:29: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 21:29: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 21:29:40 INFO - Using env: {'DISPLAY': ':0', 21:29:40 INFO - 'HOME': '/home/cltbld', 21:29:40 INFO - 'LANG': 'en_US.UTF-8', 21:29:40 INFO - 'LANGUAGE': 'en_US:en', 21:29:40 INFO - 'LOGNAME': 'cltbld', 21:29:40 INFO - 'MAIL': '/var/mail/cltbld', 21:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:40 INFO - 'MOZ_NO_REMOTE': '1', 21:29:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:40 INFO - 'NO_EM_RESTART': '1', 21:29:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:40 INFO - 'PWD': '/builds/slave/test', 21:29:40 INFO - 'SHELL': '/bin/bash', 21:29:40 INFO - 'SHLVL': '1', 21:29:40 INFO - 'TERM': 'linux', 21:29:40 INFO - 'TMOUT': '86400', 21:29:40 INFO - 'USER': 'cltbld', 21:29:40 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907', 21:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:40 INFO - '_': '/tools/buildbot/bin/python'} 21:29:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:40 INFO - Downloading/unpacking jsonschema==2.5.1 21:29: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 21:29: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 21:29: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 21:29: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 21:29: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 21:29: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 21:29:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:29:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:29: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 21:29: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 21:29: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 21:29: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 21:29: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 21:29: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 21:29:42 INFO - Downloading functools32-3.2.3-2.tar.gz 21:29:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:29:42 INFO - warning: no files found matching '*.txt' 21:29:42 INFO - no previously-included directories found matching 'build' 21:29:42 INFO - no previously-included directories found matching 'dist' 21:29:42 INFO - no previously-included directories found matching '.git*' 21:29:42 INFO - Installing collected packages: jsonschema, functools32 21:29:42 INFO - Running setup.py install for functools32 21:29:42 INFO - warning: no files found matching '*.txt' 21:29:42 INFO - no previously-included directories found matching 'build' 21:29:42 INFO - no previously-included directories found matching 'dist' 21:29:42 INFO - no previously-included directories found matching '.git*' 21:29:42 INFO - Successfully installed jsonschema functools32 21:29:42 INFO - Cleaning up... 21:29:42 INFO - Return code: 0 21:29:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:29:42 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')]} 21:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:42 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')]} 21:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:42 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 0x7fe5553bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179af60>, '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 0x179bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907', '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 21:29:42 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 21:29:42 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 21:29:42 INFO - Using env: {'DISPLAY': ':0', 21:29:42 INFO - 'HOME': '/home/cltbld', 21:29:42 INFO - 'LANG': 'en_US.UTF-8', 21:29:42 INFO - 'LANGUAGE': 'en_US:en', 21:29:42 INFO - 'LOGNAME': 'cltbld', 21:29:42 INFO - 'MAIL': '/var/mail/cltbld', 21:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:42 INFO - 'MOZ_NO_REMOTE': '1', 21:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:42 INFO - 'NO_EM_RESTART': '1', 21:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:42 INFO - 'PWD': '/builds/slave/test', 21:29:42 INFO - 'SHELL': '/bin/bash', 21:29:42 INFO - 'SHLVL': '1', 21:29:42 INFO - 'TERM': 'linux', 21:29:42 INFO - 'TMOUT': '86400', 21:29:42 INFO - 'USER': 'cltbld', 21:29:42 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907', 21:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:42 INFO - '_': '/tools/buildbot/bin/python'} 21:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:29:43 INFO - Cleaning up... 21:29:43 INFO - Return code: 0 21:29:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:29: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')]} 21:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29: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')]} 21:29:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29: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 0x7fe5553bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179af60>, '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 0x179bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907', '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 21:29: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 21:29: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 21:29:43 INFO - Using env: {'DISPLAY': ':0', 21:29:43 INFO - 'HOME': '/home/cltbld', 21:29:43 INFO - 'LANG': 'en_US.UTF-8', 21:29:43 INFO - 'LANGUAGE': 'en_US:en', 21:29:43 INFO - 'LOGNAME': 'cltbld', 21:29:43 INFO - 'MAIL': '/var/mail/cltbld', 21:29:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:43 INFO - 'MOZ_NO_REMOTE': '1', 21:29:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:43 INFO - 'NO_EM_RESTART': '1', 21:29:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:43 INFO - 'PWD': '/builds/slave/test', 21:29:43 INFO - 'SHELL': '/bin/bash', 21:29:43 INFO - 'SHLVL': '1', 21:29:43 INFO - 'TERM': 'linux', 21:29:43 INFO - 'TMOUT': '86400', 21:29:43 INFO - 'USER': 'cltbld', 21:29:43 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907', 21:29:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:43 INFO - '_': '/tools/buildbot/bin/python'} 21:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:43 INFO - Downloading/unpacking blobuploader==1.2.4 21:29: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 21:29: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 21:29: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 21:29: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 21:29: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 21:29: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 21:29:45 INFO - Downloading blobuploader-1.2.4.tar.gz 21:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:29:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:29: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 21:29: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 21:29: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 21:29: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 21:29: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 21:29: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 21:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:29:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:29: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 21:29: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 21:29: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 21:29: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 21:29: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 21:29: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 21:29:45 INFO - Downloading docopt-0.6.1.tar.gz 21:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:29:45 INFO - Installing collected packages: blobuploader, requests, docopt 21:29:45 INFO - Running setup.py install for blobuploader 21:29:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:29:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:29:46 INFO - Running setup.py install for requests 21:29:46 INFO - Running setup.py install for docopt 21:29:46 INFO - Successfully installed blobuploader requests docopt 21:29:46 INFO - Cleaning up... 21:29:46 INFO - Return code: 0 21:29:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:29:46 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')]} 21:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:46 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')]} 21:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:46 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 0x7fe5553bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179af60>, '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 0x179bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907', '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 21:29:46 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 21:29:46 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 21:29:46 INFO - Using env: {'DISPLAY': ':0', 21:29:46 INFO - 'HOME': '/home/cltbld', 21:29:46 INFO - 'LANG': 'en_US.UTF-8', 21:29:46 INFO - 'LANGUAGE': 'en_US:en', 21:29:46 INFO - 'LOGNAME': 'cltbld', 21:29:46 INFO - 'MAIL': '/var/mail/cltbld', 21:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:46 INFO - 'MOZ_NO_REMOTE': '1', 21:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:46 INFO - 'NO_EM_RESTART': '1', 21:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:46 INFO - 'PWD': '/builds/slave/test', 21:29:46 INFO - 'SHELL': '/bin/bash', 21:29:46 INFO - 'SHLVL': '1', 21:29:46 INFO - 'TERM': 'linux', 21:29:46 INFO - 'TMOUT': '86400', 21:29:46 INFO - 'USER': 'cltbld', 21:29:46 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907', 21:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:46 INFO - '_': '/tools/buildbot/bin/python'} 21:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:29:46 INFO - Running setup.py (path:/tmp/pip-CXa1Hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:29:46 INFO - Running setup.py (path:/tmp/pip-GPfywf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:29:46 INFO - Running setup.py (path:/tmp/pip-1ZtA8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:29:47 INFO - Running setup.py (path:/tmp/pip-mGqr6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:29:47 INFO - Running setup.py (path:/tmp/pip-EmYIu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:29:47 INFO - Running setup.py (path:/tmp/pip-HmZakY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:29:47 INFO - Running setup.py (path:/tmp/pip-wbO83m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:29:47 INFO - Running setup.py (path:/tmp/pip-aRx8J8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:29:47 INFO - Running setup.py (path:/tmp/pip-lp6Az_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:29:47 INFO - Running setup.py (path:/tmp/pip-3Zk9kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:29:47 INFO - Running setup.py (path:/tmp/pip-zt4Rqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:29:47 INFO - Running setup.py (path:/tmp/pip-joIPX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:29:47 INFO - Running setup.py (path:/tmp/pip-Juj5ay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:29:47 INFO - Running setup.py (path:/tmp/pip-UbC0zZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:29:47 INFO - Running setup.py (path:/tmp/pip-n5rKqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:29:47 INFO - Running setup.py (path:/tmp/pip-CjRuIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:29:47 INFO - Running setup.py (path:/tmp/pip-shEbpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:29:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:29:48 INFO - Running setup.py install for manifestparser 21:29:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:29:48 INFO - Running setup.py install for mozcrash 21:29:48 INFO - Running setup.py install for mozdebug 21:29:48 INFO - Running setup.py install for mozdevice 21:29:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:29:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:29:48 INFO - Running setup.py install for mozfile 21:29:48 INFO - Running setup.py install for mozhttpd 21:29:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:29:48 INFO - Running setup.py install for mozinfo 21:29:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:29:48 INFO - Running setup.py install for mozInstall 21:29:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:29:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:29:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:29:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:29:48 INFO - Running setup.py install for mozleak 21:29:48 INFO - Running setup.py install for mozlog 21:29:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:29:49 INFO - Running setup.py install for moznetwork 21:29:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:29:49 INFO - Running setup.py install for mozprocess 21:29:49 INFO - Running setup.py install for mozprofile 21:29:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:29:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:29:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:29:49 INFO - Running setup.py install for mozrunner 21:29:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:29:49 INFO - Running setup.py install for mozscreenshot 21:29:49 INFO - Running setup.py install for moztest 21:29:49 INFO - Running setup.py install for mozversion 21:29:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:29:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:29:49 INFO - Cleaning up... 21:29:49 INFO - Return code: 0 21:29:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:49 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 0x7fe5553bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179af60>, '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 0x179bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907', '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 21:29:49 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 21:29:49 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 21:29:49 INFO - Using env: {'DISPLAY': ':0', 21:29:49 INFO - 'HOME': '/home/cltbld', 21:29:49 INFO - 'LANG': 'en_US.UTF-8', 21:29:49 INFO - 'LANGUAGE': 'en_US:en', 21:29:49 INFO - 'LOGNAME': 'cltbld', 21:29:49 INFO - 'MAIL': '/var/mail/cltbld', 21:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:49 INFO - 'MOZ_NO_REMOTE': '1', 21:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:49 INFO - 'NO_EM_RESTART': '1', 21:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:49 INFO - 'PWD': '/builds/slave/test', 21:29:49 INFO - 'SHELL': '/bin/bash', 21:29:49 INFO - 'SHLVL': '1', 21:29:49 INFO - 'TERM': 'linux', 21:29:49 INFO - 'TMOUT': '86400', 21:29:49 INFO - 'USER': 'cltbld', 21:29:49 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907', 21:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:49 INFO - '_': '/tools/buildbot/bin/python'} 21:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:29:50 INFO - Running setup.py (path:/tmp/pip-E3fZzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:29: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)) 21:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:29:50 INFO - Running setup.py (path:/tmp/pip-jphqip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:29: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)) 21:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:29:50 INFO - Running setup.py (path:/tmp/pip-Bl_DpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:29: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)) 21:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:29:50 INFO - Running setup.py (path:/tmp/pip-bf1_Qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:29:50 INFO - Running setup.py (path:/tmp/pip-EBFncl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:29:50 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)) 21:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:29:50 INFO - Running setup.py (path:/tmp/pip-yRtA1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:29:50 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)) 21:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:29:50 INFO - Running setup.py (path:/tmp/pip-nFQUZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:29:50 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)) 21:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:29:50 INFO - Running setup.py (path:/tmp/pip-PSN04F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:29:50 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)) 21:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:29:50 INFO - Running setup.py (path:/tmp/pip-rpD4D4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:29:50 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)) 21:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:29:50 INFO - Running setup.py (path:/tmp/pip-UoNwSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:29:50 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)) 21:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:29:50 INFO - Running setup.py (path:/tmp/pip-hZXPKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:29:50 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)) 21:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:29:50 INFO - Running setup.py (path:/tmp/pip-rfLGyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:29:50 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)) 21:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:29:50 INFO - Running setup.py (path:/tmp/pip-_BQxef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:29:50 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)) 21:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:29:50 INFO - Running setup.py (path:/tmp/pip-BwFp8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:29: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)) 21:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:29:51 INFO - Running setup.py (path:/tmp/pip-7VS3at-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:29: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)) 21:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:29:51 INFO - Running setup.py (path:/tmp/pip-CnhXog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:29: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)) 21:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:29:51 INFO - Running setup.py (path:/tmp/pip-I_UsbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:29: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)) 21:29: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)) 21:29: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)) 21:29: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)) 21:29: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:29: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:29:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:29: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 21:29: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 21:29: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 21:29: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 21:29: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 21:29: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 21:29:53 INFO - Downloading blessings-1.6.tar.gz 21:29:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:29:53 INFO - Installing collected packages: blessings 21:29:53 INFO - Running setup.py install for blessings 21:29:53 INFO - Successfully installed blessings 21:29:53 INFO - Cleaning up... 21:29:53 INFO - Return code: 0 21:29:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:29:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:29:53 INFO - Reading from file tmpfile_stdout 21:29:53 INFO - Current package versions: 21:29:53 INFO - argparse == 1.2.1 21:29:53 INFO - blessings == 1.6 21:29:53 INFO - blobuploader == 1.2.4 21:29:53 INFO - docopt == 0.6.1 21:29:53 INFO - functools32 == 3.2.3-2 21:29:53 INFO - jsonschema == 2.5.1 21:29:53 INFO - manifestparser == 1.1 21:29:53 INFO - mozInstall == 1.12 21:29:53 INFO - mozcrash == 1.0 21:29:53 INFO - mozdebug == 0.1 21:29:53 INFO - mozdevice == 0.48 21:29:53 INFO - mozfile == 1.2 21:29:53 INFO - mozhttpd == 0.7 21:29:53 INFO - mozinfo == 0.9 21:29:53 INFO - mozleak == 0.1 21:29:53 INFO - mozlog == 3.4 21:29:53 INFO - moznetwork == 0.27 21:29:53 INFO - mozprocess == 0.23 21:29:53 INFO - mozprofile == 0.28 21:29:53 INFO - mozrunner == 6.13 21:29:53 INFO - mozscreenshot == 0.1 21:29:53 INFO - mozsystemmonitor == 0.3 21:29:53 INFO - moztest == 0.7 21:29:53 INFO - mozversion == 1.4 21:29:53 INFO - psutil == 3.1.1 21:29:53 INFO - requests == 1.2.3 21:29:53 INFO - wsgiref == 0.1.2 21:29:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:29:53 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')]} 21:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:53 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')]} 21:29:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:53 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 0x7fe5553bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179af60>, '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 0x179bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907', '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 21:29:53 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 21:29:53 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 21:29:53 INFO - Using env: {'DISPLAY': ':0', 21:29:53 INFO - 'HOME': '/home/cltbld', 21:29:53 INFO - 'LANG': 'en_US.UTF-8', 21:29:53 INFO - 'LANGUAGE': 'en_US:en', 21:29:53 INFO - 'LOGNAME': 'cltbld', 21:29:53 INFO - 'MAIL': '/var/mail/cltbld', 21:29:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:53 INFO - 'MOZ_NO_REMOTE': '1', 21:29:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:53 INFO - 'NO_EM_RESTART': '1', 21:29:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:53 INFO - 'PWD': '/builds/slave/test', 21:29:53 INFO - 'SHELL': '/bin/bash', 21:29:53 INFO - 'SHLVL': '1', 21:29:53 INFO - 'TERM': 'linux', 21:29:53 INFO - 'TMOUT': '86400', 21:29:53 INFO - 'USER': 'cltbld', 21:29:53 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907', 21:29:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:53 INFO - '_': '/tools/buildbot/bin/python'} 21:29:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:53 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)) 21:29:53 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)) 21:29:53 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)) 21:29:53 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)) 21:29:53 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)) 21:29:53 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)) 21:29:53 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)) 21:29:53 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)) 21:29:53 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)) 21:29:53 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)) 21:29:53 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)) 21:29:53 INFO - Cleaning up... 21:29:53 INFO - Return code: 0 21:29:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:29:53 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')]} 21:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:53 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')]} 21:29:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:53 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 0x7fe5553bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179af60>, '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 0x179bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907', '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 21:29:53 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 21:29:53 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 21:29:53 INFO - Using env: {'DISPLAY': ':0', 21:29:53 INFO - 'HOME': '/home/cltbld', 21:29:53 INFO - 'LANG': 'en_US.UTF-8', 21:29:53 INFO - 'LANGUAGE': 'en_US:en', 21:29:53 INFO - 'LOGNAME': 'cltbld', 21:29:53 INFO - 'MAIL': '/var/mail/cltbld', 21:29:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:53 INFO - 'MOZ_NO_REMOTE': '1', 21:29:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:53 INFO - 'NO_EM_RESTART': '1', 21:29:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:53 INFO - 'PWD': '/builds/slave/test', 21:29:53 INFO - 'SHELL': '/bin/bash', 21:29:53 INFO - 'SHLVL': '1', 21:29:53 INFO - 'TERM': 'linux', 21:29:53 INFO - 'TMOUT': '86400', 21:29:53 INFO - 'USER': 'cltbld', 21:29:53 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907', 21:29:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:53 INFO - '_': '/tools/buildbot/bin/python'} 21:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:29:54 INFO - Cleaning up... 21:29:54 INFO - Return code: 0 21:29:54 INFO - Running post-action listener: _resource_record_post_action 21:29:54 INFO - Running post-action listener: _start_resource_monitoring 21:29:54 INFO - Starting resource monitoring. 21:29:54 INFO - [mozharness: 2016-11-11 05:29:54.179196Z] Finished create-virtualenv step (success) 21:29:54 INFO - [mozharness: 2016-11-11 05:29:54.179699Z] Running install step. 21:29:54 INFO - Running pre-action listener: _resource_record_pre_action 21:29:54 INFO - Running main action method: install 21:29:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:29:54 INFO - Reading from file tmpfile_stdout 21:29:54 INFO - Detecting whether we're running mozinstall >=1.0... 21:29:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:29:54 INFO - Reading from file tmpfile_stdout 21:29:54 INFO - Output received: 21:29:54 INFO - Usage: mozinstall [options] installer 21:29:54 INFO - Options: 21:29:54 INFO - -h, --help show this help message and exit 21:29:54 INFO - -d DEST, --destination=DEST 21:29:54 INFO - Directory to install application into. [default: 21:29:54 INFO - "/builds/slave/test"] 21:29:54 INFO - --app=APP Application being installed. [default: firefox] 21:29:54 INFO - mkdir: /builds/slave/test/build/application 21:29:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:30:11 INFO - Reading from file tmpfile_stdout 21:30:11 INFO - Output received: 21:30:11 INFO - /builds/slave/test/build/application/firefox/firefox 21:30:11 INFO - Running post-action listener: _resource_record_post_action 21:30:11 INFO - [mozharness: 2016-11-11 05:30:11.367180Z] Finished install step (success) 21:30:11 INFO - [mozharness: 2016-11-11 05:30:11.367424Z] Running run-tests step. 21:30:11 INFO - Running pre-action listener: _resource_record_pre_action 21:30:11 INFO - Running main action method: run_tests 21:30:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:30:11 INFO - Python 2.7.3 21:30:11 INFO - Return code: 0 21:30:11 INFO - grabbing minidump binary from tooltool 21:30: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')]} 21:30: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 0x179af60>, '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 0x179bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:30: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 21:30: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 21:30: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 21:30:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:30:11 INFO - Return code: 0 21:30:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:30:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:30:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:30:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:30:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:30:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:30:11 INFO - Using env: {'DISPLAY': ':0', 21:30:11 INFO - 'HOME': '/home/cltbld', 21:30:11 INFO - 'LANG': 'en_US.UTF-8', 21:30:11 INFO - 'LANGUAGE': 'en_US:en', 21:30:11 INFO - 'LOGNAME': 'cltbld', 21:30:11 INFO - 'MAIL': '/var/mail/cltbld', 21:30:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:30:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:11 INFO - 'MOZ_NO_REMOTE': '1', 21:30:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:11 INFO - 'NO_EM_RESTART': '1', 21:30:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:11 INFO - 'PWD': '/builds/slave/test', 21:30:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:30:11 INFO - 'SHELL': '/bin/bash', 21:30:11 INFO - 'SHLVL': '1', 21:30:11 INFO - 'TERM': 'linux', 21:30:11 INFO - 'TMOUT': '86400', 21:30:11 INFO - 'USER': 'cltbld', 21:30:11 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907', 21:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:11 INFO - '_': '/tools/buildbot/bin/python'} 21:30:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:30:11 INFO - mozversion application_buildid: 20161110184015 21:30:11 INFO - mozversion application_changeset: bb7bc01deac5bf711297e216328e640aeb729895 21:30:11 INFO - mozversion application_display_name: Nightly 21:30:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:30:11 INFO - mozversion application_name: Firefox 21:30:11 INFO - mozversion application_remotingname: firefox 21:30:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:30:11 INFO - mozversion application_vendor: Mozilla 21:30:11 INFO - mozversion application_version: 52.0a1 21:30:11 INFO - mozversion platform_buildid: 20161110184015 21:30:11 INFO - mozversion platform_changeset: bb7bc01deac5bf711297e216328e640aeb729895 21:30:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:30:11 INFO - mozversion platform_version: 52.0a1 21:30:11 INFO - using testdate: 1478842211 21:30:11 INFO - actual date: 1478842211 21:30:11 INFO - starting webserver on 'localhost:52902' 21:30:11 INFO - SUITE-START | Running 2 tests 21:30:11 INFO - TEST-START | dromaeo_css 21:30:11 INFO - operating with platform_type : linux_ 21:30:11 INFO - Initialising browser for dromaeo_css test... 21:30:11 INFO - TEST-INFO | started process 3551 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphDYL2N/profile http://localhost:52902/getInfo.html) 21:30:16 INFO - PROCESS | 3551 | __metrics Screen width/height:1600/1200 21:30:16 INFO - PROCESS | 3551 | colorDepth:24 21:30:16 INFO - PROCESS | 3551 | Browser inner width/height: 1024/697 21:30:16 INFO - PROCESS | 3551 | __metrics 21:30:16 ERROR - PROCESS | 3551 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3162: TypeError: this.tabs is undefined 21:30:17 INFO - TEST-INFO | 3551: exit 0 21:30:17 INFO - Browser initialized. 21:30:17 INFO - Running cycle 1/1 for dromaeo_css test... 21:30:17 INFO - TEST-INFO | started process 3675 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphDYL2N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:30:29 INFO - PROCESS | 3675 | RSS: Main: 185143296 21:30:29 INFO - PROCESS | 3675 | 21:31:19 INFO - PROCESS | 3675 | 1478842279559 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] 21:33:30 INFO - PROCESS | 3675 | Cycle 1(1): loaded http://localhost:52902/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52902/tests/dromaeo/cssquery-ext.html) 21:33:32 INFO - PROCESS | 3675 | RSS: Main: 198295552 21:33:32 INFO - PROCESS | 3675 | 21:36:34 INFO - PROCESS | 3675 | Cycle 1(1): loaded http://localhost:52902/tests/dromaeo/cssquery-ext.html (next: http://localhost:52902/tests/dromaeo/cssquery-jquery.html) 21:36:34 INFO - PROCESS | 3675 | RSS: Main: 196284416 21:36:34 INFO - PROCESS | 3675 | 21:39:36 INFO - PROCESS | 3675 | Cycle 1(1): loaded http://localhost:52902/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52902/tests/dromaeo/cssquery-mootools.html) 21:39:37 INFO - PROCESS | 3675 | RSS: Main: 198176768 21:39:37 INFO - PROCESS | 3675 | 21:42:39 INFO - PROCESS | 3675 | Cycle 1(1): loaded http://localhost:52902/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52902/tests/dromaeo/cssquery-prototype.html) 21:42:39 INFO - PROCESS | 3675 | RSS: Main: 194940928 21:42:39 INFO - PROCESS | 3675 | 21:45:42 INFO - PROCESS | 3675 | Cycle 1(1): loaded http://localhost:52902/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52902/tests/dromaeo/cssquery-yui.html) 21:45:43 INFO - PROCESS | 3675 | RSS: Main: 198438912 21:45:43 INFO - PROCESS | 3675 | 21:48:46 INFO - PROCESS | 3675 | Cycle 1(1): loaded http://localhost:52902/tests/dromaeo/cssquery-yui.html (next: http://localhost:52902/tests/dromaeo/cssquery-dojo.html) 21:48:46 INFO - PROCESS | 3675 | RSS: Main: 198299648 21:48:46 INFO - PROCESS | 3675 | 21:48:46 INFO - PROCESS | 3675 | __start_tp_report 21:48:46 INFO - PROCESS | 3675 | _x_x_mozilla_page_load 21:48:46 INFO - PROCESS | 3675 | _x_x_mozilla_page_load_details 21:48:46 INFO - PROCESS | 3675 | |i|pagename|runs| 21:48:46 INFO - PROCESS | 3675 | |0;dojo.html;3132.3422081362914;3133.7022982816625;3140.2149462634343;3148.543461198125;3161.7470602351814;5290.153575427932;5364.79292159264;5375.139977603584;5443.537299329557;5490.80782172624;5345.118055520835;5347.037533244014;5422.105352616823;5486.094794358936;5508.531774799137;4820.156472617296;4876.536729010747;4959.8016079356785;4962.950370496303;4974.228994505857;4946.678465899723;5007.7496125193775;5063.341765570471;5071;5101.158308879049;4796.304535842283;4822.035592881402;4936.4076310842565;4993.176125939216;5017.799288028475;4767.4994125617;4776.020915712271;4799.496052914464;4808.7836047377605;4880.316755654211;4760.33355330254;4782.713037217778;4785.66500344976;4799.784009719571;4819.084373968934;5121.487851214886;5213.244079608436;5277.762500687479;5305.4164041955355;5359.062164121302;5457.372402173761;5586.91619625706;5600.327960644708;5601.887962240773;5708.80019199326;5747.8563035924435;5763.221965034709;5766.7116644168045;5769.971150144264;5906.675132867691;5351.7324133793545;5352.545033672142;5406.324209473776;5412.431694672082;5443.156310771837;5832;5841.269841269841;5909.2908850938165;5920.259967504062;5935.73289201987;5632.070708333161;5670.262865827499;5679.914801277984;5682.7442765075675;5719.656820590694;5523.1991361253195;5697.971510142505;5777.0467872801355;5777.248957635565;5780.566457515703;5534.418886016991;5603.271574695264;5612.382637909826;5653.265075540236;5668;5751.309842818889;5754.108113242454;5758.568107391962;5785.913211301834;5806.129080637938;4191.517975432865;4201.222773786798;4206.936895946563;4208.91582168361;4232.047789247456;3727.6086010968456;3741.28915506053;3771.9245615087543;3791.9810400947817;3821.522309711286;5441.5374693151525;5450.945490545044;5473.890522189614;5474.479924407175;5531.529819965268;5724.513416359573;5738.254026976467;5738.741756620962;5746;5753.194552762617;5462;5499.285092937893;5514.283143191359;5517.613767036269;5527.50252477279;4661.510541393172;4694.084653492536;4713.740744259098;4766.61867050642;4793.257045158006;6041.939580604226;6118.680093383066;6128.136482154469;6134.467201660849;6136.978641397139;5874.177615133799;5885.47030767233;5886.175935369138;5919.289685237799;5921.407859214044;5776.595638305278;5849.766009359748;6100.481459075851;6105.908411373922;6109.816705498843;5621.775128994958;5624.212610234488;5668.461496157858;5701.372848986691;5707.086866101404;5729.169270455844;5757.8560535986935;5763.510101641407;5764.625299355528;5772.538196944319;5559;5607.074832652566;5609.074502707008;5630.4369563045;5635.464630860061;5342.599305052059;5373.919391209213;5384.461553844584;5464.23500709893;5531.640443371168;5433.809816656398;5515.503604675599;5530.198121272312;5606.719664016864;5628.409017053151;5433.809816656398;5472.288602481652;5567.944320556742;5590.468905453975;5655.406182350794;5553.888922221614;5563.221149039218;5566.582506312124;5606.850595627805;5615 21:48:46 INFO - PROCESS | 3675 | |1;ext.html;521.447265898148;560.5235549782684;570.6119838509811;580.6777238632559;604.7913469852899;31241.218969525773;40826.795866020664;41901.79049104758;41977;42088.57911420881;42431.36352954708;42758.358624620654;42860.78569607155;43021.139577208436;43032.569674303326;8513.233808957193;8614.267787238061;8625.353098517637;8645.740627781146;8672.653093876268;8509.872351914695;8557.48655080694;8559;8568.528730919797;8573.785655358604;8556.229939305462;8590.226879580836;8614.095519970408;8628.525431101287;8659.740207793777;8574.228319451247;8589.527575983318;8610.483370997728;8624.266937310367;8636.870446943301;8375.874361884577;8394.202550757669;8461.15388461155;8465.449745766568;8468.364872634576;40485.79757101196;40774.592254077375;40836.38745418821;40864.38703419451;40904.59095409067;3577.266660334625;3586.2110335726097;3832.693384529231;4013;4079.4492743479545;29948.251293717614;30198.69801301981;30786.53820192699;30874.228144296572;30993.845030774926;4025.3496066612843;4031.798410079514;4078.2455245779624;4175.185838761443;4236.173946080516;304358;305866;306542;306731;307008;55675.72162139163;56187.438125618224;56193.71903140458;56340.718296409075;56397.43602563922;59608.70195648994;59860;59921;59969;60150.398496015354;14301.499447519287;14476.276186190858;14479.131252124906;14482.275886205858;14541.418343266363;11458.484368203284;11505.769884602429;11531.711707207387;11536.538538458535;11714.531418743325;16140.919295403683;16711.41510047167;16916.915415422845;16942.661146776994;17303.56741081483;5901.911471327933;6169.537284703665;6175.722092505848;6203.720832562545;6250.281217660027;927.6011315134422;1026.5637104230673;1043.8329867221207;1052.9684109476727;1053.3942982784777;30811.8459407706;31127.91052313158;31253.843730781202;31640.36719265648;31789;1030.7062487191115;1080.2384319055204;1103.5309993252836;1129.8700649425257;1172.1560476456937;15352.769708454382;16173.353065877232;16201.756973645404;16278.51164465068;16305.673886522203;410059;417499;418018;418521;418652;54216;54612.72693636506;54661.72669136629;55109;55234.171487427724;1319.617310979805;1329.2489743295007;1337.6789570503204;1345.4685399267235;1352.5671785028894;29972.550411743407;31348.529772053895;32459.18852028718;32600.510992335607;32849;47788.28317575309;48428.75785621049;48468;48645;48891.53325400244;340478;341318;342033;342223;342600;27033;27084.32289192786;27158.456830863666;27591.86204068967;27622.447551049267;44714.3292850614;44754.3286850691;45453.31820022769;46171.30743038924;46503.76748116373;37626.62373376231;37721.05697357588;38432.615673842905;38815;39261.214775704895;37857.432138518496;38446.2310753789;38525.61474385332;38624.80687596544;38654.226915462095;38090.42864357092;39286.80356598199;39990.40014399844;40083.198336033696;40113.59886401215;29467.945382004327;32442.62024626645;34475.13812154716;34513.48229776606;34651.4802277961;26747.465050699266;27028.45943081088;27086.322841929108;27472.862635686695;27675.308117297227 21:48:46 INFO - PROCESS | 3675 | |2;jquery.html;384.1337783298663;394.40444928158473;396.4608132939204;397.43564138922727;410.55044726024994;16042.117683527402;16640;17380.47858564242;18633.627327453443;18782.90608546957;11088.833667494973;11476.770464590703;11613.47739351729;11621.663508696502;11662.650120496399;4736.976315118428;5006.799728010875;5012.047710934929;5018.222175562793;5019.924701129486;4854.199057155565;4936.35827342445;5027.899442011158;5029.924551131736;5062.215356619729;5088;5089.949100509003;5093.6943783372935;5096.61775366849;5098.235264710304;4857.927131093036;4862.270659401082;5033.572146367563;5081.415637201713;5092.516210959953;4750.691205071659;4767.713937163747;4769.761511924425;4780.976095119502;4788.736619485927;12453.75092498154;12655.62033138998;16461;21626.783732162636;21898.562028759494;2178.7603363629987;2385.8329916905823;2439.902403903842;2640.075973409311;2810.7189281071933;5790.189373487715;9429.952850235773;9854.11312981835;12228.877711222864;13368.598942031755;1758.001638815092;1772.1670814717063;1795.9044982560627;1854.4158590044092;1930.3243864647402;78100.60949695272;78831.605841971;79308;79554.20445795526;82441;10841.241113122005;11107;11118.833217501744;11286.516966267409;11315.490802913888;15727.764083538756;15786.289616967035;15875.603109922344;15883.682326353408;15913.124778137313;7459.962700186465;7649.694012239448;7714.267144621252;7852.450328476952;7886.566238856918;7048.224695283515;7201.135863696285;7343.963280183565;7371.336579707852;7382.704691812267;4638.141943740419;4724.692894961817;4730;4786.329913812069;4788.329633851264;1859.674556952555;1887.518682735921;1976.7529058867642;1985.602879424121;2027.4525878012853;878.3193025405362;964.8229160424271;969.8108868770522;971.1987610221596;1005.597760895633;17852.322151677094;19444;19582.608347833248;19743.50641233952;19791.10940007703;984.7636567223815;1000.1198944928417;1014.4065721552827;1019.4444028004607;1025.994870025645;8124.512529248264;10431.217658675478;10931;10981.12151027916;11019.779604407868;435211;437556;443170;444159;444375;63943;86329.56835215783;88773.11226887649;89575.55212223897;90972;912.2302732698676;920.2178148573793;943.6084025129494;946.0066929723763;948.2129832239225;16588.087655179083;16767.748483772997;17327.133643318037;17470.912645436692;17611.295548177928;39862.40206396848;39891.202175956896;40333.1933361337;40923.7953810229;41048;54542.18186727123;55132.44867551434;55178;56301.991681330794;56368.718156408955;7755.146933837161;8038.879416808635;8056.637451314587;8513.489190648581;8680.82638347217;12013.939930300292;12925;13042.673933151747;13157.671058223621;13183.340832958505;11355.489002995051;11445.599404020819;11547.191696581158;11647.825282620937;11823.881761182278;10819.56721731122;10918.836217456586;10989.725256868322;11017.338959662446;11598.362090084789;11370.43147842588;11593.420328983348;11621.128415368712;11682.007029402595;11767.117466189899;8007.199280071946;8244.54654993981;8361.665533378597;8436.578171091298;8934.106589341274;8139.18608139205;10668.359898406121;11505.309681419141;11589.710257243636;11613.825792612948 21:48:46 INFO - PROCESS | 3675 | |3;mootools.html;1438.3096113865347;1457.7959085727996;1547.806524184477;1658.7511873219023;1676.2038031934826;6889.655517224144;7110.680019399127;7300.123985121786;7686.5772382518935;7744.574048427335;7241.71033158673;7586;7594;7716.768496945087;7721.613919304041;2095.4132842803965;2102.632039393108;2109.8101170894693;2113.133615217761;2115.936521904345;2134.925277615284;2162.264829957814;2216.1135545781653;2220.6113930062256;2225.1655629139073;2175.5213852952406;2185.2024011235862;2185.748638906522;2190.7371115466167;2204.9559008819815;2153.8923053847243;2157.892105394724;2159.341400872733;2170.2946542373793;2184.5958497677902;2165.740111186652;2212.9336119916265;2224.6440569508964;2232.586971410294;2237.8545394549465;7703.422243331773;7714.691412343555;7721.305082542598;7732.690692372298;7765.378769698411;4725.952740472586;4905.681130726527;4906.705597664151;4911.852644420673;4933.333999910002;2963.733264006228;3079.1532328609587;3172.5558421820965;3180.3957248123015;3197.2965947491516;973.1144658360928;988.0958922585826;1002.7443002034507;1037.6938803053117;1064.7391389109719;9853.605855765833;9910.752231194207;9935.453550054744;9986.400815951067;9990.850137247948;4165.875023749292;4212.873613791591;4278.251306021434;4281.443412356373;4298.89252768677;8559.22966932979;8580.699675511452;8615.310775137974;8615.353848461391;8615.870761938577;4797.880052998633;4817.108834865561;4824.638152138604;4835.975820120877;4843.854684359475;4316.381356991128;4432.445944256968;4505.1440226357545;4522.5025247222775;4572;3280.2455435250026;3396.4226081566194;3432.5022871683964;3441.6214216436174;3510.140015696171;1054.3831858362944;1063.7181146996052;1066.3335415365398;1089.6349722842779;1105.7567335186245;778.6106946526737;821.5850995247362;882.0782282514788;916.2852974679761;950.8383574792302;5272.103742363807;5288.233206185082;5296.894062118736;5304.310439642822;5312.389075256395;880.8502554565739;898.667493027584;933.1368484152132;948.60081379964;955.5938726041404;3672.320620685182;3673.9265214695556;3688.3360995020616;3735.458358538051;3749.081475038633;8685.91314086851;8873.645054197888;8944.642214311485;9029.503377314311;9051.27589792815;8862.955685221532;8866.822663546693;8872.24585910205;8877.33419993503;8884.422512536665;7098.503104782616;7130.108736407949;7190.568565886064;7239.855202895913;7263.673134709056;5013.172826483736;5041.546260836542;5187.507186817246;5221.9216711748595;5281.841544753664;7702.191269916578;7900.051993760785;8359.122292159236;8493.575321234037;8497.91502084996;8289.04675962272;8428.536430496137;8471.129982357974;8510;8572.828543428972;7032.12098487689;7204.71181152769;7300.342969132804;7337.596432196067;7355.411567074728;7575.166731659623;7589.506682065648;7597.392208623407;7623.580703061385;7679.462437629312;6584.407403333723;6699.7990060296315;6752.696128674123;6784.3554862288;6898.448124150156;6713.798586042427;6720.8319792005595;6741.460683145435;6791.694373753094;6808;5968.731407086779;6007.459328660441;6072.939270607238;6084.087386892002;6100.938990610037;4422.248217803046;4557.202489564379;4616.007558374966;4656.208444564364;4757;4566.589006989387;4573.977130114461;4615.353850461005;4693.765311734468;4704.223803072455 21:48:46 INFO - PROCESS | 3675 | |4;prototype.html;314.74505650423157;317.9491281394976;320.39605343926706;321.1265358225626;324.7548101183607;5399.325084364455;5436.401995780466;5457.699826509541;5478.835634930953;5485.451454854512;5317.574594032478;5321.813736519222;5339.866503337418;5346.4118946915805;5374.838754837351;4008.7128554585324;4108.781258120612;4139.627433530982;4165.250254954107;4241.1305682335205;4149.792510374469;4167.145620198998;4189.434426352449;4198.286291330466;4216.7680777557225;4152.958470415288;4155.729877557949;4171.374293855915;4192.2244384788755;4205.558416366268;4105.856295029689;4111.814968326417;4142.647874930634;4185.8534951276715;4207.221663992141;3643.2713457308378;3647.835847386874;3651.707863370924;3659.835307411173;3660.890173294805;5202.609804264657;5214.592060143778;5224.843254702365;5226.608004399685;5230.320058392384;4399.934000989988;4619.514950930171;4732.313814496913;4732.384789977315;4772.260299653559;5554.91667624986;5559.942821156158;5572.637778544382;5580.581456390787;5610.607257491936;3862.6523612874694;3868.883933482;3872.7220017394475;3889.572147063821;3893.8247778849736;5442;5741.483266506035;5782.797602083949;5833.300003999505;5840.941590584125;3957.52509698838;3994.3409337459575;4012.879613611596;4013.779242141652;4019.2363450944226;4069.7761623111014;4077.1641813428178;4110.540758030916;4113.1568028554075;4114.362273847559;4619.260918253063;4692.272697731857;4714.175019371665;4723.535703931792;4737.526247375235;5573.303337082864;5609.551235901118;5659.349174844863;5662.5753068520025;5682.232898558642;1363.522767031531;1377.5178687459509;1378.1386633354155;1384.536180379584;1384.819973403451;849.6261644876234;879.8649741833092;913.8752400668473;929.1637526226315;930.4649826349876;5056.873578160502;5298.999999999923;5425.864353391197;5433.083059830859;5442.374126975448;5742.13867919807;5752.856178595485;5764.279465066867;5776.653400795965;5814.680192589448;5328.600354973392;5418.859550477539;5451.047990207068;5456.645318054314;5461.726913654302;2903.8983635573077;2935.9266018349713;2947.60207372002;2949.73452389286;2956.9556456653168;5744.684042377709;5751.654900705971;5763.567732420085;5791.768329266866;5793.2179155814265;5365.839024829262;5587.580931430159;5603.8792241551855;5615.669497158715;5627.774889004476;5684.749355141945;5702.657840529581;5741.368449470471;5768.3654797972185;5787.247657804459;5193.61047921415;5403.675779453245;5508.834734957958;5513.724313784375;5545.279113715191;5442.374126975448;5452.863678407913;5452.863678408072;5461.836144915659;5468.562514998711;5719.771209151588;5754.136879468113;5774.39368866263;5808.5353171747;5814.651120932757;3754.7559408639445;3765.284595926765;3792.5209168423785;3837.731358804857;3877.6316249956208;5534.86162845916;5544.556435485232;5549.278593782782;5556;5582.162675598693;5326.2276969838385;5396.64921780083;5431.565474762088;5433.468245640365;5452.918206226989;5280.392754833243;5421.2139239810795;5607.971960140173;5636.492715655447;5651.632643878134;5590.8043218487155;5591.04952158126;5591.804286849941;5596.440355964371;5604.8318550443555;5428.212909128233;5491.9725401374335;5575.0522411191005;5602.747876345656;5611;5497.3952865184;5506.64206826555;5564.721763911707;5574.885022995336;5583.497485226187 21:48:46 INFO - PROCESS | 3675 | |5;yui.html;709.354487416451;729.5294535024913;765.2729906588738;786.6342150899831;815.8694608862581;12418.565350212744;13103.558608553052;13454.932725336372;13461.596152115451;13643.454261829515;12341.938290308535;12572.497100115985;12632.810507842367;12633.178843375197;12763.553275635355;775.4843029385452;778.9571573563466;786.5634572812087;796.4544287163283;797.2107613462688;802.0415603353995;804.7625950344633;808.9474184178039;810.1331575214523;810.3193317613204;836.5691668790578;839.6347588798861;839.8782176584392;842.6081871929551;843.241083025276;838.0822998816286;841.6254766628853;842.7808769719855;843.2916350265745;845.382870504529;610.2859654204547;615.4706952021259;616.7995401494533;618.8855061813534;619.4486906653083;13199.472021119143;13409.86590134096;13568.728625427535;13578.796318055238;13586.524471643444;12992.155509891922;13229.470821167142;13254.536091236856;13363.33183340829;13367.532136375277;10984.340939543574;11064.17018723599;11095.723991740972;11218.495167717472;11432.142589305835;3488.354654388946;3525.6474352564537;3648.3980143276326;3667.8349474273723;3675.3016926784094;68321.31678683199;71247;71647.2835271651;72546.27453725447;72815.63592182005;9534.332596718303;9864.63248820278;10178.592856285666;11105.500252488657;11495.3677547734;19362.515937101685;20059.097340619708;20065.29771458021;20150.29473968404;20175.59648807045;7370.96314518424;7445.218252083561;7741.225877412214;7789.844203115906;7790.182030886788;4007.438958545806;4112.753234805921;4167.708260421741;4192.664586833046;4380.2772542530765;3385.272166484218;3525.959841846661;3531.134871956387;3532.5054492371087;3533.1520435095904;617.962922224668;623.2520974830222;630.4263120560269;645.0517738923775;650.2554575011585;590.503976659608;647.757091090841;674.8481591641842;726.5096060159372;727.3562896836232;9029.23251523628;9549.952250238843;9616.326857120075;9638.228941684649;9813.754656133653;588.0913987888722;655.7213184396612;699.4020112803581;718.8562287542512;734.6473692627569;4253.468316460442;4826.61387089032;4852.878678033077;4853.757312134449;4894.461609222983;85067;85580;87592.5620371894;88108.5594572023;89912;78864.60567697124;79391;80902.59548702337;81142.59428702819;82094.66545480036;44121.55878441239;59151.70424147852;69557.65221173862;70829;71160.2883971164;8786.297096232414;8888.422252553823;8913.37606367548;8950.552472376225;9189.540522973959;33766.831165845;44140.33789493224;45636.77181614071;46460.53539464562;48206.27690584714;59839.40160598513;65450.67274663596;66275.33724662692;66614.33385666081;67499.66250168718;10826.40454774995;11387.715307117389;11416.815387666005;11535.753344619556;12084.395780210778;12605;12684.492620295085;12700.428480718205;13648.181109133484;13676.93161534186;12351.629451116482;12429.12996090265;12478.5008599655;12487.689777391211;13141.211527308393;11622.94188529052;11906.285622862655;12004.75990480168;12059.336736479227;12513.186642868184;11560.768784624428;11982.460789264329;12436.19164754288;12669.113162078565;12706.618801435972;9855.162311203629;10154.746131346776;10302.793944120926;10370.481475926023;10813.513391897226;10157.238207134642;10465.639466869563;10871.151904176468;10896.945515272373;10912.127029837435 21:48:46 INFO - PROCESS | 3675 | __end_tp_report 21:48:46 INFO - PROCESS | 3675 | __start_cc_report 21:48:46 INFO - PROCESS | 3675 | _x_x_mozilla_cycle_collect,308 21:48:46 INFO - PROCESS | 3675 | __end_cc_report 21:48:46 INFO - PROCESS | 3675 | __startTimestamp1478843326573__endTimestamp 21:48:46 INFO - PROCESS | 3675 | 21:48:46 INFO - PROCESS | 3675 | ------- Summary: start ------- 21:48:46 INFO - PROCESS | 3675 | Number of tests: 6 21:48:46 INFO - PROCESS | 3675 | 21:48:46 INFO - PROCESS | 3675 | [#0] dojo.html Cycles:165 Average:5322.87 Median:5523.20 stddev:634.62 (11.5%) stddev-sans-first:612.86 21:48:46 INFO - PROCESS | 3675 | Values: 3132.3 3133.7 3140.2 3148.5 3161.7 5290.2 5364.8 5375.1 5443.5 5490.8 5345.1 5347.0 5422.1 5486.1 5508.5 4820.2 4876.5 4959.8 4963.0 4974.2 4946.7 5007.7 5063.3 5071.0 5101.2 4796.3 4822.0 4936.4 4993.2 5017.8 4767.5 4776.0 4799.5 4808.8 4880.3 4760.3 4782.7 4785.7 4799.8 4819.1 5121.5 5213.2 5277.8 5305.4 5359.1 5457.4 5586.9 5600.3 5601.9 5708.8 5747.9 5763.2 5766.7 5770.0 5906.7 5351.7 5352.5 5406.3 5412.4 5443.2 5832.0 5841.3 5909.3 5920.3 5935.7 5632.1 5670.3 5679.9 5682.7 5719.7 5523.2 5698.0 5777.0 5777.2 5780.6 5534.4 5603.3 5612.4 5653.3 5668.0 5751.3 5754.1 5758.6 5785.9 5806.1 4191.5 4201.2 4206.9 4208.9 4232.0 3727.6 3741.3 3771.9 3792.0 3821.5 5441.5 5450.9 5473.9 5474.5 5531.5 5724.5 5738.3 5738.7 5746.0 5753.2 5462.0 5499.3 5514.3 5517.6 5527.5 4661.5 4694.1 4713.7 4766.6 4793.3 6041.9 6118.7 6128.1 6134.5 6137.0 5874.2 5885.5 5886.2 5919.3 5921.4 5776.6 5849.8 6100.5 6105.9 6109.8 5621.8 5624.2 5668.5 5701.4 5707.1 5729.2 5757.9 5763.5 5764.6 5772.5 5559.0 5607.1 5609.1 5630.4 5635.5 5342.6 5373.9 5384.5 5464.2 5531.6 5433.8 5515.5 5530.2 5606.7 5628.4 5433.8 5472.3 5567.9 5590.5 5655.4 5553.9 5563.2 5566.6 5606.9 5615.0 21:48:46 INFO - PROCESS | 3675 | 21:48:46 INFO - PROCESS | 3675 | [#1] ext.html Cycles:180 Average:51939.04 Median:40036.80 stddev:94171.16 (235.2%) stddev-sans-first:94356.21 21:48:46 INFO - PROCESS | 3675 | Values: 521.4 560.5 570.6 580.7 604.8 31241.2 40826.8 41901.8 41977.0 42088.6 42431.4 42758.4 42860.8 43021.1 43032.6 8513.2 8614.3 8625.4 8645.7 8672.7 8509.9 8557.5 8559.0 8568.5 8573.8 8556.2 8590.2 8614.1 8628.5 8659.7 8574.2 8589.5 8610.5 8624.3 8636.9 8375.9 8394.2 8461.2 8465.4 8468.4 40485.8 40774.6 40836.4 40864.4 40904.6 3577.3 3586.2 3832.7 4013.0 4079.4 29948.3 30198.7 30786.5 30874.2 30993.8 4025.3 4031.8 4078.2 4175.2 4236.2 304358.0 305866.0 306542.0 306731.0 307008.0 55675.7 56187.4 56193.7 56340.7 56397.4 59608.7 59860.0 59921.0 59969.0 60150.4 14301.5 14476.3 14479.1 14482.3 14541.4 11458.5 11505.8 11531.7 11536.5 11714.5 16140.9 16711.4 16916.9 16942.7 17303.6 5901.9 6169.5 6175.7 6203.7 6250.3 927.6 1026.6 1043.8 1053.0 1053.4 30811.8 31127.9 31253.8 31640.4 31789.0 1030.7 1080.2 1103.5 1129.9 1172.2 15352.8 16173.4 16201.8 16278.5 16305.7 410059.0 417499.0 418018.0 418521.0 418652.0 54216.0 54612.7 54661.7 55109.0 55234.2 1319.6 1329.2 1337.7 1345.5 1352.6 29972.6 31348.5 32459.2 32600.5 32849.0 47788.3 48428.8 48468.0 48645.0 48891.5 340478.0 341318.0 342033.0 342223.0 342600.0 27033.0 27084.3 27158.5 27591.9 27622.4 44714.3 44754.3 45453.3 46171.3 46503.8 37626.6 37721.1 38432.6 38815.0 39261.2 37857.4 38446.2 38525.6 38624.8 38654.2 38090.4 39286.8 39990.4 40083.2 40113.6 29467.9 32442.6 34475.1 34513.5 34651.5 26747.5 27028.5 27086.3 27472.9 27675.3 21:48:46 INFO - PROCESS | 3675 | 21:48:46 INFO - PROCESS | 3675 | [#2] jquery.html Cycles:180 Average:26630.58 Median:40112.20 stddev:72882.75 (181.7%) stddev-sans-first:73060.56 21:48:46 INFO - PROCESS | 3675 | Values: 384.1 394.4 396.5 397.4 410.6 16042.1 16640.0 17380.5 18633.6 18782.9 11088.8 11476.8 11613.5 11621.7 11662.7 4737.0 5006.8 5012.0 5018.2 5019.9 4854.2 4936.4 5027.9 5029.9 5062.2 5088.0 5089.9 5093.7 5096.6 5098.2 4857.9 4862.3 5033.6 5081.4 5092.5 4750.7 4767.7 4769.8 4781.0 4788.7 12453.8 12655.6 16461.0 21626.8 21898.6 2178.8 2385.8 2439.9 2640.1 2810.7 5790.2 9430.0 9854.1 12228.9 13368.6 1758.0 1772.2 1795.9 1854.4 1930.3 78100.6 78831.6 79308.0 79554.2 82441.0 10841.2 11107.0 11118.8 11286.5 11315.5 15727.8 15786.3 15875.6 15883.7 15913.1 7460.0 7649.7 7714.3 7852.5 7886.6 7048.2 7201.1 7344.0 7371.3 7382.7 4638.1 4724.7 4730.0 4786.3 4788.3 1859.7 1887.5 1976.8 1985.6 2027.5 878.3 964.8 969.8 971.2 1005.6 17852.3 19444.0 19582.6 19743.5 19791.1 984.8 1000.1 1014.4 1019.4 1026.0 8124.5 10431.2 10931.0 10981.1 11019.8 435211.0 437556.0 443170.0 444159.0 444375.0 63943.0 86329.6 88773.1 89575.6 90972.0 912.2 920.2 943.6 946.0 948.2 16588.1 16767.7 17327.1 17470.9 17611.3 39862.4 39891.2 40333.2 40923.8 41048.0 54542.2 55132.4 55178.0 56302.0 56368.7 7755.1 8038.9 8056.6 8513.5 8680.8 12013.9 12925.0 13042.7 13157.7 13183.3 11355.5 11445.6 11547.2 11647.8 11823.9 10819.6 10918.8 10989.7 11017.3 11598.4 11370.4 11593.4 11621.1 11682.0 11767.1 8007.2 8244.5 8361.7 8436.6 8934.1 8139.2 10668.4 11505.3 11589.7 11613.8 21:48:46 INFO - PROCESS | 3675 | 21:48:46 INFO - PROCESS | 3675 | [#3] mootools.html Cycles:180 Average:5051.04 Median:5300.60 stddev:2691.23 (50.8%) stddev-sans-first:2685.08 21:48:46 INFO - PROCESS | 3675 | Values: 1438.3 1457.8 1547.8 1658.8 1676.2 6889.7 7110.7 7300.1 7686.6 7744.6 7241.7 7586.0 7594.0 7716.8 7721.6 2095.4 2102.6 2109.8 2113.1 2115.9 2134.9 2162.3 2216.1 2220.6 2225.2 2175.5 2185.2 2185.7 2190.7 2205.0 2153.9 2157.9 2159.3 2170.3 2184.6 2165.7 2212.9 2224.6 2232.6 2237.9 7703.4 7714.7 7721.3 7732.7 7765.4 4726.0 4905.7 4906.7 4911.9 4933.3 2963.7 3079.2 3172.6 3180.4 3197.3 973.1 988.1 1002.7 1037.7 1064.7 9853.6 9910.8 9935.5 9986.4 9990.9 4165.9 4212.9 4278.3 4281.4 4298.9 8559.2 8580.7 8615.3 8615.4 8615.9 4797.9 4817.1 4824.6 4836.0 4843.9 4316.4 4432.4 4505.1 4522.5 4572.0 3280.2 3396.4 3432.5 3441.6 3510.1 1054.4 1063.7 1066.3 1089.6 1105.8 778.6 821.6 882.1 916.3 950.8 5272.1 5288.2 5296.9 5304.3 5312.4 880.9 898.7 933.1 948.6 955.6 3672.3 3673.9 3688.3 3735.5 3749.1 8685.9 8873.6 8944.6 9029.5 9051.3 8863.0 8866.8 8872.2 8877.3 8884.4 7098.5 7130.1 7190.6 7239.9 7263.7 5013.2 5041.5 5187.5 5221.9 5281.8 7702.2 7900.1 8359.1 8493.6 8497.9 8289.0 8428.5 8471.1 8510.0 8572.8 7032.1 7204.7 7300.3 7337.6 7355.4 7575.2 7589.5 7597.4 7623.6 7679.5 6584.4 6699.8 6752.7 6784.4 6898.4 6713.8 6720.8 6741.5 6791.7 6808.0 5968.7 6007.5 6072.9 6084.1 6100.9 4422.2 4557.2 4616.0 4656.2 4757.0 4566.6 4574.0 4615.4 4693.8 4704.2 21:48:46 INFO - PROCESS | 3675 | 21:48:46 INFO - PROCESS | 3675 | [#4] prototype.html Cycles:180 Average:4648.09 Median:5420.04 stddev:1375.78 (25.4%) stddev-sans-first:1340.64 21:48:46 INFO - PROCESS | 3675 | Values: 314.7 317.9 320.4 321.1 324.8 5399.3 5436.4 5457.7 5478.8 5485.5 5317.6 5321.8 5339.9 5346.4 5374.8 4008.7 4108.8 4139.6 4165.3 4241.1 4149.8 4167.1 4189.4 4198.3 4216.8 4153.0 4155.7 4171.4 4192.2 4205.6 4105.9 4111.8 4142.6 4185.9 4207.2 3643.3 3647.8 3651.7 3659.8 3660.9 5202.6 5214.6 5224.8 5226.6 5230.3 4399.9 4619.5 4732.3 4732.4 4772.3 5554.9 5559.9 5572.6 5580.6 5610.6 3862.7 3868.9 3872.7 3889.6 3893.8 5442.0 5741.5 5782.8 5833.3 5840.9 3957.5 3994.3 4012.9 4013.8 4019.2 4069.8 4077.2 4110.5 4113.2 4114.4 4619.3 4692.3 4714.2 4723.5 4737.5 5573.3 5609.6 5659.3 5662.6 5682.2 1363.5 1377.5 1378.1 1384.5 1384.8 849.6 879.9 913.9 929.2 930.5 5056.9 5299.0 5425.9 5433.1 5442.4 5742.1 5752.9 5764.3 5776.7 5814.7 5328.6 5418.9 5451.0 5456.6 5461.7 2903.9 2935.9 2947.6 2949.7 2957.0 5744.7 5751.7 5763.6 5791.8 5793.2 5365.8 5587.6 5603.9 5615.7 5627.8 5684.7 5702.7 5741.4 5768.4 5787.2 5193.6 5403.7 5508.8 5513.7 5545.3 5442.4 5452.9 5452.9 5461.8 5468.6 5719.8 5754.1 5774.4 5808.5 5814.7 3754.8 3765.3 3792.5 3837.7 3877.6 5534.9 5544.6 5549.3 5556.0 5582.2 5326.2 5396.6 5431.6 5433.5 5452.9 5280.4 5421.2 5608.0 5636.5 5651.6 5590.8 5591.0 5591.8 5596.4 5604.8 5428.2 5492.0 5575.1 5602.7 5611.0 5497.4 5506.6 5564.7 5574.9 5583.5 21:48:46 INFO - PROCESS | 3675 | 21:48:46 INFO - PROCESS | 3675 | [#5] yui.html Cycles:180 Average:17665.51 Median:4853.32 stddev:24103.89 (496.6%) stddev-sans-first:24137.88 21:48:46 INFO - PROCESS | 3675 | Values: 709.4 729.5 765.3 786.6 815.9 12418.6 13103.6 13454.9 13461.6 13643.5 12341.9 12572.5 12632.8 12633.2 12763.6 775.5 779.0 786.6 796.5 797.2 802.0 804.8 808.9 810.1 810.3 836.6 839.6 839.9 842.6 843.2 838.1 841.6 842.8 843.3 845.4 610.3 615.5 616.8 618.9 619.4 13199.5 13409.9 13568.7 13578.8 13586.5 12992.2 13229.5 13254.5 13363.3 13367.5 10984.3 11064.2 11095.7 11218.5 11432.1 3488.4 3525.6 3648.4 3667.8 3675.3 68321.3 71247.0 71647.3 72546.3 72815.6 9534.3 9864.6 10178.6 11105.5 11495.4 19362.5 20059.1 20065.3 20150.3 20175.6 7371.0 7445.2 7741.2 7789.8 7790.2 4007.4 4112.8 4167.7 4192.7 4380.3 3385.3 3526.0 3531.1 3532.5 3533.2 618.0 623.3 630.4 645.1 650.3 590.5 647.8 674.8 726.5 727.4 9029.2 9550.0 9616.3 9638.2 9813.8 588.1 655.7 699.4 718.9 734.6 4253.5 4826.6 4852.9 4853.8 4894.5 85067.0 85580.0 87592.6 88108.6 89912.0 78864.6 79391.0 80902.6 81142.6 82094.7 44121.6 59151.7 69557.7 70829.0 71160.3 8786.3 8888.4 8913.4 8950.6 9189.5 33766.8 44140.3 45636.8 46460.5 48206.3 59839.4 65450.7 66275.3 66614.3 67499.7 10826.4 11387.7 11416.8 11535.8 12084.4 12605.0 12684.5 12700.4 13648.2 13676.9 12351.6 12429.1 12478.5 12487.7 13141.2 11622.9 11906.3 12004.8 12059.3 12513.2 11560.8 11982.5 12436.2 12669.1 12706.6 9855.2 10154.7 10302.8 10370.5 10813.5 10157.2 10465.6 10871.2 10896.9 10912.1 21:48:46 INFO - PROCESS | 3675 | -------- Summary: end -------- 21:48:46 INFO - PROCESS | 3675 | 21:48:47 INFO - TEST-INFO | 3675: exit 0 21:48:47 INFO - TEST-OK | dromaeo_css | took 1115998ms 21:48:47 INFO - TEST-START | kraken 21:48:47 INFO - operating with platform_type : linux_ 21:48:47 INFO - Initialising browser for kraken test... 21:48:47 INFO - TEST-INFO | started process 4035 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPxNWb3/profile http://localhost:52902/getInfo.html) 21:48:52 INFO - PROCESS | 4035 | __metrics Screen width/height:1600/1200 21:48:52 INFO - PROCESS | 4035 | colorDepth:24 21:48:52 INFO - PROCESS | 4035 | Browser inner width/height: 1024/697 21:48:52 INFO - PROCESS | 4035 | __metrics 21:48:52 ERROR - PROCESS | 4035 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3162: TypeError: this.tabs is undefined 21:48:53 INFO - TEST-INFO | 4035: exit 0 21:48:53 INFO - Browser initialized. 21:48:53 INFO - Running cycle 1/1 for kraken test... 21:48:53 INFO - TEST-INFO | started process 4158 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPxNWb3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:49:05 INFO - PROCESS | 4158 | RSS: Main: 185942016 21:49:05 INFO - PROCESS | 4158 | 21:49:08 INFO - PROCESS | 4158 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52902/tests/kraken/driver.html?testName=audio-beat-detection) 21:49:09 INFO - PROCESS | 4158 | RSS: Main: 198344704 21:49:09 INFO - PROCESS | 4158 | 21:49:12 INFO - PROCESS | 4158 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52902/tests/kraken/driver.html?testName=audio-dft) 21:49:12 INFO - PROCESS | 4158 | RSS: Main: 196624384 21:49:12 INFO - PROCESS | 4158 | 21:49:15 INFO - PROCESS | 4158 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52902/tests/kraken/driver.html?testName=audio-fft) 21:49:16 INFO - PROCESS | 4158 | RSS: Main: 193675264 21:49:16 INFO - PROCESS | 4158 | 21:49:18 INFO - PROCESS | 4158 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52902/tests/kraken/driver.html?testName=audio-oscillator) 21:49:18 INFO - PROCESS | 4158 | RSS: Main: 193884160 21:49:18 INFO - PROCESS | 4158 | 21:49:21 INFO - PROCESS | 4158 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52902/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:49:21 INFO - PROCESS | 4158 | RSS: Main: 193847296 21:49:21 INFO - PROCESS | 4158 | 21:49:24 INFO - PROCESS | 4158 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52902/tests/kraken/driver.html?testName=imaging-darkroom) 21:49:25 INFO - PROCESS | 4158 | RSS: Main: 199327744 21:49:25 INFO - PROCESS | 4158 | 21:49:28 INFO - PROCESS | 4158 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52902/tests/kraken/driver.html?testName=imaging-desaturate) 21:49:29 INFO - PROCESS | 4158 | RSS: Main: 195780608 21:49:29 INFO - PROCESS | 4158 | 21:49:32 INFO - PROCESS | 4158 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52902/tests/kraken/driver.html?testName=json-parse-financial) 21:49:32 INFO - PROCESS | 4158 | RSS: Main: 196931584 21:49:32 INFO - PROCESS | 4158 | 21:49:34 INFO - PROCESS | 4158 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52902/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:49:35 INFO - PROCESS | 4158 | RSS: Main: 196694016 21:49:35 INFO - PROCESS | 4158 | 21:49:36 INFO - PROCESS | 4158 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52902/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:49:37 INFO - PROCESS | 4158 | RSS: Main: 197148672 21:49:37 INFO - PROCESS | 4158 | 21:49:39 INFO - PROCESS | 4158 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52902/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:49:40 INFO - PROCESS | 4158 | RSS: Main: 197238784 21:49:40 INFO - PROCESS | 4158 | 21:49:42 INFO - PROCESS | 4158 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:49:43 INFO - PROCESS | 4158 | RSS: Main: 197271552 21:49:43 INFO - PROCESS | 4158 | 21:49:46 INFO - PROCESS | 4158 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:49:47 INFO - PROCESS | 4158 | RSS: Main: 197304320 21:49:47 INFO - PROCESS | 4158 | 21:49:48 INFO - PROCESS | 4158 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52902/tests/kraken/driver.html?testName=ai-astar) 21:49:49 INFO - PROCESS | 4158 | RSS: Main: 198791168 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | __start_tp_report 21:49:49 INFO - PROCESS | 4158 | _x_x_mozilla_page_load 21:49:49 INFO - PROCESS | 4158 | _x_x_mozilla_page_load_details 21:49:49 INFO - PROCESS | 4158 | |i|pagename|runs| 21:49:49 INFO - PROCESS | 4158 | |0;ai-astar;107;114;116;114;114;119;113;115;113;114 21:49:49 INFO - PROCESS | 4158 | |1;audio-beat-detection;159;124;127;172;132;126;126;127;158;124 21:49:49 INFO - PROCESS | 4158 | |2;audio-dft;165;163;164;165;176;161;163;163;162;161 21:49:49 INFO - PROCESS | 4158 | |3;audio-fft;78;77;77;113;77;78;79;76;104;76 21:49:49 INFO - PROCESS | 4158 | |4;audio-oscillator;84;84;110;84;84;82;100;83;82;112 21:49:49 INFO - PROCESS | 4158 | |5;imaging-gaussian-blur;118;118;118;118;119;118;117;121;118;117 21:49:49 INFO - PROCESS | 4158 | |6;imaging-darkroom;149;148;147;146;146;148;148;152;149;147 21:49:49 INFO - PROCESS | 4158 | |7;imaging-desaturate;86;85;86;86;87;85;86;85;85;85 21:49:49 INFO - PROCESS | 4158 | |8;json-parse-financial;52;53;55;55;57;55;55;57;58;54 21:49:49 INFO - PROCESS | 4158 | |9;json-stringify-tinderbox;63;63;63;64;64;63;63;63;65;64 21:49:49 INFO - PROCESS | 4158 | |10;stanford-crypto-aes;81;90;80;79;81;81;81;86;81;81 21:49:49 INFO - PROCESS | 4158 | |11;stanford-crypto-ccm;133;148;147;140;134;140;146;145;183;133 21:49:49 INFO - PROCESS | 4158 | |12;stanford-crypto-pbkdf2;170;163;169;167;171;177;168;165;169;164 21:49:49 INFO - PROCESS | 4158 | |13;stanford-crypto-sha256-iterative;65;69;65;68;65;66;64;69;65;64 21:49:49 INFO - PROCESS | 4158 | __end_tp_report 21:49:49 INFO - PROCESS | 4158 | __start_cc_report 21:49:49 INFO - PROCESS | 4158 | _x_x_mozilla_cycle_collect,818 21:49:49 INFO - PROCESS | 4158 | __end_cc_report 21:49:49 INFO - PROCESS | 4158 | __startTimestamp1478843389113__endTimestamp 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | ------- Summary: start ------- 21:49:49 INFO - PROCESS | 4158 | Number of tests: 14 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:3.00 (2.6%) stddev-sans-first:1.87 21:49:49 INFO - PROCESS | 4158 | Values: 107.0 114.0 116.0 114.0 114.0 119.0 113.0 115.0 113.0 114.0 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | [#1] audio-beat-detection Cycles:10 Average:137.50 Median:129.50 stddev:18.11 (14.0%) stddev-sans-first:17.46 21:49:49 INFO - PROCESS | 4158 | Values: 159.0 124.0 127.0 172.0 132.0 126.0 126.0 127.0 158.0 124.0 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.50 stddev:4.35 (2.7%) stddev-sans-first:4.60 21:49:49 INFO - PROCESS | 4158 | Values: 165.0 163.0 164.0 165.0 176.0 161.0 163.0 163.0 162.0 161.0 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | [#3] audio-fft Cycles:10 Average:83.50 Median:77.00 stddev:13.38 (17.4%) stddev-sans-first:14.04 21:49:49 INFO - PROCESS | 4158 | Values: 78.0 77.0 77.0 113.0 77.0 78.0 79.0 76.0 104.0 76.0 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:83.50 stddev:12.03 (14.4%) stddev-sans-first:12.53 21:49:49 INFO - PROCESS | 4158 | Values: 84.0 84.0 110.0 84.0 84.0 82.0 100.0 83.0 82.0 112.0 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.14 (1.0%) stddev-sans-first:1.20 21:49:49 INFO - PROCESS | 4158 | Values: 118.0 118.0 118.0 118.0 119.0 118.0 117.0 121.0 118.0 117.0 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.76 (1.2%) stddev-sans-first:1.83 21:49:49 INFO - PROCESS | 4158 | Values: 149.0 148.0 147.0 146.0 146.0 148.0 148.0 152.0 149.0 147.0 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 21:49:49 INFO - PROCESS | 4158 | Values: 86.0 85.0 86.0 86.0 87.0 85.0 86.0 85.0 85.0 85.0 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:1.85 (3.4%) stddev-sans-first:1.59 21:49:49 INFO - PROCESS | 4158 | Values: 52.0 53.0 55.0 55.0 57.0 55.0 55.0 57.0 58.0 54.0 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:63.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 21:49:49 INFO - PROCESS | 4158 | Values: 63.0 63.0 63.0 64.0 64.0 63.0 63.0 63.0 65.0 64.0 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:81.00 stddev:3.31 (4.1%) stddev-sans-first:3.49 21:49:49 INFO - PROCESS | 4158 | Values: 81.0 90.0 80.0 79.0 81.0 81.0 81.0 86.0 81.0 81.0 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:145.50 stddev:14.59 (10.0%) stddev-sans-first:14.83 21:49:49 INFO - PROCESS | 4158 | Values: 133.0 148.0 147.0 140.0 134.0 140.0 146.0 145.0 183.0 133.0 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:169.00 stddev:4.03 (2.4%) stddev-sans-first:4.23 21:49:49 INFO - PROCESS | 4158 | Values: 170.0 163.0 169.0 167.0 171.0 177.0 168.0 165.0 169.0 164.0 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:65.50 stddev:1.94 (3.0%) stddev-sans-first:2.03 21:49:49 INFO - PROCESS | 4158 | Values: 65.0 69.0 65.0 68.0 65.0 66.0 64.0 69.0 65.0 64.0 21:49:49 INFO - PROCESS | 4158 | -------- Summary: end -------- 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | 21:49:49 INFO - PROCESS | 4158 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv 21:49:49 INFO - PROCESS | 4158 | 21:49:50 INFO - TEST-INFO | 4158: exit 0 21:49:50 INFO - TEST-OK | kraken | took 62651ms 21:49:50 INFO - SUITE-END | took 1178s 21:49:50 INFO - Completed test suite (00:19:39) 21:49:50 INFO - javascript benchmark 21:49:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6853.395061117696, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.3422081362914, 3133.7022982816625, 3140.2149462634343, 3148.543461198125, 3161.7470602351814, 5290.153575427932, 5364.79292159264, 5375.139977603584, 5443.537299329557, 5490.80782172624, 5345.118055520835, 5347.037533244014, 5422.105352616823, 5486.094794358936, 5508.531774799137, 4820.156472617296, 4876.536729010747, 4959.8016079356785, 4962.950370496303, 4974.228994505857, 4946.678465899723, 5007.7496125193775, 5063.341765570471, 5071.0, 5101.158308879049, 4796.304535842283, 4822.035592881402, 4936.4076310842565, 4993.176125939216, 5017.799288028475, 4767.4994125617, 4776.020915712271, 4799.496052914464, 4808.7836047377605, 4880.316755654211, 4760.33355330254, 4782.713037217778, 4785.66500344976, 4799.784009719571, 4819.084373968934, 5121.487851214886, 5213.244079608436, 5277.762500687479, 5305.4164041955355, 5359.062164121302, 5457.372402173761, 5586.91619625706, 5600.327960644708, 5601.887962240773, 5708.80019199326, 5747.8563035924435, 5763.221965034709, 5766.7116644168045, 5769.971150144264, 5906.675132867691, 5351.7324133793545, 5352.545033672142, 5406.324209473776, 5412.431694672082, 5443.156310771837, 5832.0, 5841.269841269841, 5909.2908850938165, 5920.259967504062, 5935.73289201987, 5632.070708333161, 5670.262865827499, 5679.914801277984, 5682.7442765075675, 5719.656820590694, 5523.1991361253195, 5697.971510142505, 5777.0467872801355, 5777.248957635565, 5780.566457515703, 5534.418886016991, 5603.271574695264, 5612.382637909826, 5653.265075540236, 5668.0, 5751.309842818889, 5754.108113242454, 5758.568107391962, 5785.913211301834, 5806.129080637938, 4191.517975432865, 4201.222773786798, 4206.936895946563, 4208.91582168361, 4232.047789247456, 3727.6086010968456, 3741.28915506053, 3771.9245615087543, 3791.9810400947817, 3821.522309711286, 5441.5374693151525, 5450.945490545044, 5473.890522189614, 5474.479924407175, 5531.529819965268, 5724.513416359573, 5738.254026976467, 5738.741756620962, 5746.0, 5753.194552762617, 5462.0, 5499.285092937893, 5514.283143191359, 5517.613767036269, 5527.50252477279, 4661.510541393172, 4694.084653492536, 4713.740744259098, 4766.61867050642, 4793.257045158006, 6041.939580604226, 6118.680093383066, 6128.136482154469, 6134.467201660849, 6136.978641397139, 5874.177615133799, 5885.47030767233, 5886.175935369138, 5919.289685237799, 5921.407859214044, 5776.595638305278, 5849.766009359748, 6100.481459075851, 6105.908411373922, 6109.816705498843, 5621.775128994958, 5624.212610234488, 5668.461496157858, 5701.372848986691, 5707.086866101404, 5729.169270455844, 5757.8560535986935, 5763.510101641407, 5764.625299355528, 5772.538196944319, 5559.0, 5607.074832652566, 5609.074502707008, 5630.4369563045, 5635.464630860061, 5342.599305052059, 5373.919391209213, 5384.461553844584, 5464.23500709893, 5531.640443371168, 5433.809816656398, 5515.503604675599, 5530.198121272312, 5606.719664016864, 5628.409017053151, 5433.809816656398, 5472.288602481652, 5567.944320556742, 5590.468905453975, 5655.406182350794, 5553.888922221614, 5563.221149039218, 5566.582506312124, 5606.850595627805, 5615.0], "value": 5278.403496451869, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [521.447265898148, 560.5235549782684, 570.6119838509811, 580.6777238632559, 604.7913469852899, 31241.218969525773, 40826.795866020664, 41901.79049104758, 41977.0, 42088.57911420881, 42431.36352954708, 42758.358624620654, 42860.78569607155, 43021.139577208436, 43032.569674303326, 8513.233808957193, 8614.267787238061, 8625.353098517637, 8645.740627781146, 8672.653093876268, 8509.872351914695, 8557.48655080694, 8559.0, 8568.528730919797, 8573.785655358604, 8556.229939305462, 8590.226879580836, 8614.095519970408, 8628.525431101287, 8659.740207793777, 8574.228319451247, 8589.527575983318, 8610.483370997728, 8624.266937310367, 8636.870446943301, 8375.874361884577, 8394.202550757669, 8461.15388461155, 8465.449745766568, 8468.364872634576, 40485.79757101196, 40774.592254077375, 40836.38745418821, 40864.38703419451, 40904.59095409067, 3577.266660334625, 3586.2110335726097, 3832.693384529231, 4013.0, 4079.4492743479545, 29948.251293717614, 30198.69801301981, 30786.53820192699, 30874.228144296572, 30993.845030774926, 4025.3496066612843, 4031.798410079514, 4078.2455245779624, 4175.185838761443, 4236.173946080516, 304358.0, 305866.0, 306542.0, 306731.0, 307008.0, 55675.72162139163, 56187.438125618224, 56193.71903140458, 56340.718296409075, 56397.43602563922, 59608.70195648994, 59860.0, 59921.0, 59969.0, 60150.398496015354, 14301.499447519287, 14476.276186190858, 14479.131252124906, 14482.275886205858, 14541.418343266363, 11458.484368203284, 11505.769884602429, 11531.711707207387, 11536.538538458535, 11714.531418743325, 16140.919295403683, 16711.41510047167, 16916.915415422845, 16942.661146776994, 17303.56741081483, 5901.911471327933, 6169.537284703665, 6175.722092505848, 6203.720832562545, 6250.281217660027, 927.6011315134422, 1026.5637104230673, 1043.8329867221207, 1052.9684109476727, 1053.3942982784777, 30811.8459407706, 31127.91052313158, 31253.843730781202, 31640.36719265648, 31789.0, 1030.7062487191115, 1080.2384319055204, 1103.5309993252836, 1129.8700649425257, 1172.1560476456937, 15352.769708454382, 16173.353065877232, 16201.756973645404, 16278.51164465068, 16305.673886522203, 410059.0, 417499.0, 418018.0, 418521.0, 418652.0, 54216.0, 54612.72693636506, 54661.72669136629, 55109.0, 55234.171487427724, 1319.617310979805, 1329.2489743295007, 1337.6789570503204, 1345.4685399267235, 1352.5671785028894, 29972.550411743407, 31348.529772053895, 32459.18852028718, 32600.510992335607, 32849.0, 47788.28317575309, 48428.75785621049, 48468.0, 48645.0, 48891.53325400244, 340478.0, 341318.0, 342033.0, 342223.0, 342600.0, 27033.0, 27084.32289192786, 27158.456830863666, 27591.86204068967, 27622.447551049267, 44714.3292850614, 44754.3286850691, 45453.31820022769, 46171.30743038924, 46503.76748116373, 37626.62373376231, 37721.05697357588, 38432.615673842905, 38815.0, 39261.214775704895, 37857.432138518496, 38446.2310753789, 38525.61474385332, 38624.80687596544, 38654.226915462095, 38090.42864357092, 39286.80356598199, 39990.40014399844, 40083.198336033696, 40113.59886401215, 29467.945382004327, 32442.62024626645, 34475.13812154716, 34513.48229776606, 34651.4802277961, 26747.465050699266, 27028.45943081088, 27086.322841929108, 27472.862635686695, 27675.308117297227], "value": 18911.92374518505, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.1337783298663, 394.40444928158473, 396.4608132939204, 397.43564138922727, 410.55044726024994, 16042.117683527402, 16640.0, 17380.47858564242, 18633.627327453443, 18782.90608546957, 11088.833667494973, 11476.770464590703, 11613.47739351729, 11621.663508696502, 11662.650120496399, 4736.976315118428, 5006.799728010875, 5012.047710934929, 5018.222175562793, 5019.924701129486, 4854.199057155565, 4936.35827342445, 5027.899442011158, 5029.924551131736, 5062.215356619729, 5088.0, 5089.949100509003, 5093.6943783372935, 5096.61775366849, 5098.235264710304, 4857.927131093036, 4862.270659401082, 5033.572146367563, 5081.415637201713, 5092.516210959953, 4750.691205071659, 4767.713937163747, 4769.761511924425, 4780.976095119502, 4788.736619485927, 12453.75092498154, 12655.62033138998, 16461.0, 21626.783732162636, 21898.562028759494, 2178.7603363629987, 2385.8329916905823, 2439.902403903842, 2640.075973409311, 2810.7189281071933, 5790.189373487715, 9429.952850235773, 9854.11312981835, 12228.877711222864, 13368.598942031755, 1758.001638815092, 1772.1670814717063, 1795.9044982560627, 1854.4158590044092, 1930.3243864647402, 78100.60949695272, 78831.605841971, 79308.0, 79554.20445795526, 82441.0, 10841.241113122005, 11107.0, 11118.833217501744, 11286.516966267409, 11315.490802913888, 15727.764083538756, 15786.289616967035, 15875.603109922344, 15883.682326353408, 15913.124778137313, 7459.962700186465, 7649.694012239448, 7714.267144621252, 7852.450328476952, 7886.566238856918, 7048.224695283515, 7201.135863696285, 7343.963280183565, 7371.336579707852, 7382.704691812267, 4638.141943740419, 4724.692894961817, 4730.0, 4786.329913812069, 4788.329633851264, 1859.674556952555, 1887.518682735921, 1976.7529058867642, 1985.602879424121, 2027.4525878012853, 878.3193025405362, 964.8229160424271, 969.8108868770522, 971.1987610221596, 1005.597760895633, 17852.322151677094, 19444.0, 19582.608347833248, 19743.50641233952, 19791.10940007703, 984.7636567223815, 1000.1198944928417, 1014.4065721552827, 1019.4444028004607, 1025.994870025645, 8124.512529248264, 10431.217658675478, 10931.0, 10981.12151027916, 11019.779604407868, 435211.0, 437556.0, 443170.0, 444159.0, 444375.0, 63943.0, 86329.56835215783, 88773.11226887649, 89575.55212223897, 90972.0, 912.2302732698676, 920.2178148573793, 943.6084025129494, 946.0066929723763, 948.2129832239225, 16588.087655179083, 16767.748483772997, 17327.133643318037, 17470.912645436692, 17611.295548177928, 39862.40206396848, 39891.202175956896, 40333.1933361337, 40923.7953810229, 41048.0, 54542.18186727123, 55132.44867551434, 55178.0, 56301.991681330794, 56368.718156408955, 7755.146933837161, 8038.879416808635, 8056.637451314587, 8513.489190648581, 8680.82638347217, 12013.939930300292, 12925.0, 13042.673933151747, 13157.671058223621, 13183.340832958505, 11355.489002995051, 11445.599404020819, 11547.191696581158, 11647.825282620937, 11823.881761182278, 10819.56721731122, 10918.836217456586, 10989.725256868322, 11017.338959662446, 11598.362090084789, 11370.43147842588, 11593.420328983348, 11621.128415368712, 11682.007029402595, 11767.117466189899, 8007.199280071946, 8244.54654993981, 8361.665533378597, 8436.578171091298, 8934.106589341274, 8139.18608139205, 10668.359898406121, 11505.309681419141, 11589.710257243636, 11613.825792612948], "value": 8627.037714631746, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1438.3096113865347, 1457.7959085727996, 1547.806524184477, 1658.7511873219023, 1676.2038031934826, 6889.655517224144, 7110.680019399127, 7300.123985121786, 7686.5772382518935, 7744.574048427335, 7241.71033158673, 7586.0, 7594.0, 7716.768496945087, 7721.613919304041, 2095.4132842803965, 2102.632039393108, 2109.8101170894693, 2113.133615217761, 2115.936521904345, 2134.925277615284, 2162.264829957814, 2216.1135545781653, 2220.6113930062256, 2225.1655629139073, 2175.5213852952406, 2185.2024011235862, 2185.748638906522, 2190.7371115466167, 2204.9559008819815, 2153.8923053847243, 2157.892105394724, 2159.341400872733, 2170.2946542373793, 2184.5958497677902, 2165.740111186652, 2212.9336119916265, 2224.6440569508964, 2232.586971410294, 2237.8545394549465, 7703.422243331773, 7714.691412343555, 7721.305082542598, 7732.690692372298, 7765.378769698411, 4725.952740472586, 4905.681130726527, 4906.705597664151, 4911.852644420673, 4933.333999910002, 2963.733264006228, 3079.1532328609587, 3172.5558421820965, 3180.3957248123015, 3197.2965947491516, 973.1144658360928, 988.0958922585826, 1002.7443002034507, 1037.6938803053117, 1064.7391389109719, 9853.605855765833, 9910.752231194207, 9935.453550054744, 9986.400815951067, 9990.850137247948, 4165.875023749292, 4212.873613791591, 4278.251306021434, 4281.443412356373, 4298.89252768677, 8559.22966932979, 8580.699675511452, 8615.310775137974, 8615.353848461391, 8615.870761938577, 4797.880052998633, 4817.108834865561, 4824.638152138604, 4835.975820120877, 4843.854684359475, 4316.381356991128, 4432.445944256968, 4505.1440226357545, 4522.5025247222775, 4572.0, 3280.2455435250026, 3396.4226081566194, 3432.5022871683964, 3441.6214216436174, 3510.140015696171, 1054.3831858362944, 1063.7181146996052, 1066.3335415365398, 1089.6349722842779, 1105.7567335186245, 778.6106946526737, 821.5850995247362, 882.0782282514788, 916.2852974679761, 950.8383574792302, 5272.103742363807, 5288.233206185082, 5296.894062118736, 5304.310439642822, 5312.389075256395, 880.8502554565739, 898.667493027584, 933.1368484152132, 948.60081379964, 955.5938726041404, 3672.320620685182, 3673.9265214695556, 3688.3360995020616, 3735.458358538051, 3749.081475038633, 8685.91314086851, 8873.645054197888, 8944.642214311485, 9029.503377314311, 9051.27589792815, 8862.955685221532, 8866.822663546693, 8872.24585910205, 8877.33419993503, 8884.422512536665, 7098.503104782616, 7130.108736407949, 7190.568565886064, 7239.855202895913, 7263.673134709056, 5013.172826483736, 5041.546260836542, 5187.507186817246, 5221.9216711748595, 5281.841544753664, 7702.191269916578, 7900.051993760785, 8359.122292159236, 8493.575321234037, 8497.91502084996, 8289.04675962272, 8428.536430496137, 8471.129982357974, 8510.0, 8572.828543428972, 7032.12098487689, 7204.71181152769, 7300.342969132804, 7337.596432196067, 7355.411567074728, 7575.166731659623, 7589.506682065648, 7597.392208623407, 7623.580703061385, 7679.462437629312, 6584.407403333723, 6699.7990060296315, 6752.696128674123, 6784.3554862288, 6898.448124150156, 6713.798586042427, 6720.8319792005595, 6741.460683145435, 6791.694373753094, 6808.0, 5968.731407086779, 6007.459328660441, 6072.939270607238, 6084.087386892002, 6100.938990610037, 4422.248217803046, 4557.202489564379, 4616.007558374966, 4656.208444564364, 4757.0, 4566.589006989387, 4573.977130114461, 4615.353850461005, 4693.765311734468, 4704.223803072455], "value": 4129.546098732818, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.74505650423157, 317.9491281394976, 320.39605343926706, 321.1265358225626, 324.7548101183607, 5399.325084364455, 5436.401995780466, 5457.699826509541, 5478.835634930953, 5485.451454854512, 5317.574594032478, 5321.813736519222, 5339.866503337418, 5346.4118946915805, 5374.838754837351, 4008.7128554585324, 4108.781258120612, 4139.627433530982, 4165.250254954107, 4241.1305682335205, 4149.792510374469, 4167.145620198998, 4189.434426352449, 4198.286291330466, 4216.7680777557225, 4152.958470415288, 4155.729877557949, 4171.374293855915, 4192.2244384788755, 4205.558416366268, 4105.856295029689, 4111.814968326417, 4142.647874930634, 4185.8534951276715, 4207.221663992141, 3643.2713457308378, 3647.835847386874, 3651.707863370924, 3659.835307411173, 3660.890173294805, 5202.609804264657, 5214.592060143778, 5224.843254702365, 5226.608004399685, 5230.320058392384, 4399.934000989988, 4619.514950930171, 4732.313814496913, 4732.384789977315, 4772.260299653559, 5554.91667624986, 5559.942821156158, 5572.637778544382, 5580.581456390787, 5610.607257491936, 3862.6523612874694, 3868.883933482, 3872.7220017394475, 3889.572147063821, 3893.8247778849736, 5442.0, 5741.483266506035, 5782.797602083949, 5833.300003999505, 5840.941590584125, 3957.52509698838, 3994.3409337459575, 4012.879613611596, 4013.779242141652, 4019.2363450944226, 4069.7761623111014, 4077.1641813428178, 4110.540758030916, 4113.1568028554075, 4114.362273847559, 4619.260918253063, 4692.272697731857, 4714.175019371665, 4723.535703931792, 4737.526247375235, 5573.303337082864, 5609.551235901118, 5659.349174844863, 5662.5753068520025, 5682.232898558642, 1363.522767031531, 1377.5178687459509, 1378.1386633354155, 1384.536180379584, 1384.819973403451, 849.6261644876234, 879.8649741833092, 913.8752400668473, 929.1637526226315, 930.4649826349876, 5056.873578160502, 5298.999999999923, 5425.864353391197, 5433.083059830859, 5442.374126975448, 5742.13867919807, 5752.856178595485, 5764.279465066867, 5776.653400795965, 5814.680192589448, 5328.600354973392, 5418.859550477539, 5451.047990207068, 5456.645318054314, 5461.726913654302, 2903.8983635573077, 2935.9266018349713, 2947.60207372002, 2949.73452389286, 2956.9556456653168, 5744.684042377709, 5751.654900705971, 5763.567732420085, 5791.768329266866, 5793.2179155814265, 5365.839024829262, 5587.580931430159, 5603.8792241551855, 5615.669497158715, 5627.774889004476, 5684.749355141945, 5702.657840529581, 5741.368449470471, 5768.3654797972185, 5787.247657804459, 5193.61047921415, 5403.675779453245, 5508.834734957958, 5513.724313784375, 5545.279113715191, 5442.374126975448, 5452.863678407913, 5452.863678408072, 5461.836144915659, 5468.562514998711, 5719.771209151588, 5754.136879468113, 5774.39368866263, 5808.5353171747, 5814.651120932757, 3754.7559408639445, 3765.284595926765, 3792.5209168423785, 3837.731358804857, 3877.6316249956208, 5534.86162845916, 5544.556435485232, 5549.278593782782, 5556.0, 5582.162675598693, 5326.2276969838385, 5396.64921780083, 5431.565474762088, 5433.468245640365, 5452.918206226989, 5280.392754833243, 5421.2139239810795, 5607.971960140173, 5636.492715655447, 5651.632643878134, 5590.8043218487155, 5591.04952158126, 5591.804286849941, 5596.440355964371, 5604.8318550443555, 5428.212909128233, 5491.9725401374335, 5575.0522411191005, 5602.747876345656, 5611.0, 5497.3952865184, 5506.64206826555, 5564.721763911707, 5574.885022995336, 5583.497485226187], "value": 4201.583459838947, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.354487416451, 729.5294535024913, 765.2729906588738, 786.6342150899831, 815.8694608862581, 12418.565350212744, 13103.558608553052, 13454.932725336372, 13461.596152115451, 13643.454261829515, 12341.938290308535, 12572.497100115985, 12632.810507842367, 12633.178843375197, 12763.553275635355, 775.4843029385452, 778.9571573563466, 786.5634572812087, 796.4544287163283, 797.2107613462688, 802.0415603353995, 804.7625950344633, 808.9474184178039, 810.1331575214523, 810.3193317613204, 836.5691668790578, 839.6347588798861, 839.8782176584392, 842.6081871929551, 843.241083025276, 838.0822998816286, 841.6254766628853, 842.7808769719855, 843.2916350265745, 845.382870504529, 610.2859654204547, 615.4706952021259, 616.7995401494533, 618.8855061813534, 619.4486906653083, 13199.472021119143, 13409.86590134096, 13568.728625427535, 13578.796318055238, 13586.524471643444, 12992.155509891922, 13229.470821167142, 13254.536091236856, 13363.33183340829, 13367.532136375277, 10984.340939543574, 11064.17018723599, 11095.723991740972, 11218.495167717472, 11432.142589305835, 3488.354654388946, 3525.6474352564537, 3648.3980143276326, 3667.8349474273723, 3675.3016926784094, 68321.31678683199, 71247.0, 71647.2835271651, 72546.27453725447, 72815.63592182005, 9534.332596718303, 9864.63248820278, 10178.592856285666, 11105.500252488657, 11495.3677547734, 19362.515937101685, 20059.097340619708, 20065.29771458021, 20150.29473968404, 20175.59648807045, 7370.96314518424, 7445.218252083561, 7741.225877412214, 7789.844203115906, 7790.182030886788, 4007.438958545806, 4112.753234805921, 4167.708260421741, 4192.664586833046, 4380.2772542530765, 3385.272166484218, 3525.959841846661, 3531.134871956387, 3532.5054492371087, 3533.1520435095904, 617.962922224668, 623.2520974830222, 630.4263120560269, 645.0517738923775, 650.2554575011585, 590.503976659608, 647.757091090841, 674.8481591641842, 726.5096060159372, 727.3562896836232, 9029.23251523628, 9549.952250238843, 9616.326857120075, 9638.228941684649, 9813.754656133653, 588.0913987888722, 655.7213184396612, 699.4020112803581, 718.8562287542512, 734.6473692627569, 4253.468316460442, 4826.61387089032, 4852.878678033077, 4853.757312134449, 4894.461609222983, 85067.0, 85580.0, 87592.5620371894, 88108.5594572023, 89912.0, 78864.60567697124, 79391.0, 80902.59548702337, 81142.59428702819, 82094.66545480036, 44121.55878441239, 59151.70424147852, 69557.65221173862, 70829.0, 71160.2883971164, 8786.297096232414, 8888.422252553823, 8913.37606367548, 8950.552472376225, 9189.540522973959, 33766.831165845, 44140.33789493224, 45636.77181614071, 46460.53539464562, 48206.27690584714, 59839.40160598513, 65450.67274663596, 66275.33724662692, 66614.33385666081, 67499.66250168718, 10826.40454774995, 11387.715307117389, 11416.815387666005, 11535.753344619556, 12084.395780210778, 12605.0, 12684.492620295085, 12700.428480718205, 13648.181109133484, 13676.93161534186, 12351.629451116482, 12429.12996090265, 12478.5008599655, 12487.689777391211, 13141.211527308393, 11622.94188529052, 11906.285622862655, 12004.75990480168, 12059.336736479227, 12513.186642868184, 11560.768784624428, 11982.460789264329, 12436.19164754288, 12669.113162078565, 12706.618801435972, 9855.162311203629, 10154.746131346776, 10302.793944120926, 10370.481475926023, 10813.513391897226, 10157.238207134642, 10465.639466869563, 10871.151904176468, 10896.945515272373, 10912.127029837435], "value": 6933.823447239415, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 114.0, 116.0, 114.0, 114.0, 119.0, 113.0, 115.0, 113.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 124.0, 127.0, 172.0, 132.0, 126.0, 126.0, 127.0, 158.0, 124.0], "value": 137.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 164.0, 165.0, 176.0, 161.0, 163.0, 163.0, 162.0, 161.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 113.0, 77.0, 78.0, 79.0, 76.0, 104.0, 76.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 110.0, 84.0, 84.0, 82.0, 100.0, 83.0, 82.0, 112.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 117.0, 121.0, 118.0, 117.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 146.0, 146.0, 148.0, 148.0, 152.0, 149.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 86.0, 87.0, 85.0, 86.0, 85.0, 85.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 55.0, 55.0, 57.0, 55.0, 55.0, 57.0, 58.0, 54.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 64.0, 63.0, 63.0, 63.0, 65.0, 64.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 90.0, 80.0, 79.0, 81.0, 81.0, 81.0, 86.0, 81.0, 81.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 148.0, 147.0, 140.0, 134.0, 140.0, 146.0, 145.0, 183.0, 133.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 163.0, 169.0, 167.0, 171.0, 177.0, 168.0, 165.0, 169.0, 164.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 65.0, 68.0, 65.0, 66.0, 64.0, 69.0, 65.0, 64.0], "value": 66.0, "unit": "score"}]}]} 21:49:50 INFO - Return code: 0 21:49:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:49:50 ERROR - # TBPL SUCCESS # 21:49:50 INFO - Running post-action listener: _resource_record_post_action 21:49:50 INFO - [mozharness: 2016-11-11 05:49:50.916217Z] Finished run-tests step (success) 21:49:50 INFO - Running post-run listener: _resource_record_post_run 21:49:50 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 402190336; Read time: 12; Write time: 263108 21:49:50 INFO - TinderboxPrint: CPU usage
13.4% 21:49:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:49:50 INFO - TinderboxPrint: I/O write bytes / time
402,190,336 / 263,108 21:49:50 INFO - TinderboxPrint: CPU idle
8,254.2 (86.5%) 21:49:50 INFO - TinderboxPrint: CPU user
1,219.8 (12.8%) 21:49:50 INFO - TinderboxPrint: Swap in / out
0 / 0 21:49:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114036736; Read time: 0; Write time: 74324 21:49:51 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287580160; Read time: 0; Write time: 188760 21:49:51 INFO - Running post-run listener: _upload_blobber_files 21:49:51 INFO - Blob upload gear active. 21:49:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:49:51 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 21:49:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:49:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:49:51 INFO - (blobuploader) - INFO - Open directory for files ... 21:49:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:49:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:49:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:49:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:49:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:49:52 INFO - (blobuploader) - INFO - Done attempting. 21:49:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:49:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:49:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:49:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:49:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:49:53 INFO - (blobuploader) - INFO - Done attempting. 21:49:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:49:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:49:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:49:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:49:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:49:56 INFO - (blobuploader) - INFO - Done attempting. 21:49:56 INFO - (blobuploader) - INFO - Iteration through files over. 21:49:56 INFO - Return code: 0 21:49:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:49:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:49:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/59e8bb8bf315344e285031e6f8705e291c75ad43a55da71250eee81ff7aedc090a641b4689510f8848f7bad86e76416618b1769b59c59547b2a6ee5f5774b492", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eba0ed3cb305ca5b816cca3c9afb6ee8f6b54ca0cb4a96b24037c063b16d6b5dc1066ca9302ff0ca66320f57b1216533b907ee76abe26657f5f64d81135d763c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e7f0297e2f71c5093adeeba57ff0ec56631e4c179186fc1d376581fc436440e84dd3e610bb93ddc09c45d428304285488ca3fd3d3edd80975c8277df9cbbb929"} 21:49:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:49:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:49:56 INFO - Contents: 21:49:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/59e8bb8bf315344e285031e6f8705e291c75ad43a55da71250eee81ff7aedc090a641b4689510f8848f7bad86e76416618b1769b59c59547b2a6ee5f5774b492", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eba0ed3cb305ca5b816cca3c9afb6ee8f6b54ca0cb4a96b24037c063b16d6b5dc1066ca9302ff0ca66320f57b1216533b907ee76abe26657f5f64d81135d763c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e7f0297e2f71c5093adeeba57ff0ec56631e4c179186fc1d376581fc436440e84dd3e610bb93ddc09c45d428304285488ca3fd3d3edd80975c8277df9cbbb929"} 21:49:56 INFO - Running post-run listener: copy_logs_to_upload_dir 21:49:56 INFO - Copying logs to upload dir... 21:49:56 INFO - mkdir: /builds/slave/test/build/upload/logs 21:49:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.733659 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-10 21:49:56.172078) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-10 21:49:56.175669) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907 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/Mozilla-Inbound/sha512/59e8bb8bf315344e285031e6f8705e291c75ad43a55da71250eee81ff7aedc090a641b4689510f8848f7bad86e76416618b1769b59c59547b2a6ee5f5774b492", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eba0ed3cb305ca5b816cca3c9afb6ee8f6b54ca0cb4a96b24037c063b16d6b5dc1066ca9302ff0ca66320f57b1216533b907ee76abe26657f5f64d81135d763c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e7f0297e2f71c5093adeeba57ff0ec56631e4c179186fc1d376581fc436440e84dd3e610bb93ddc09c45d428304285488ca3fd3d3edd80975c8277df9cbbb929"} build_url:https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011534 build_url: 'https://queue.taskcluster.net/v1/task/DpkORWxLQKKl0aOfNN3YqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/59e8bb8bf315344e285031e6f8705e291c75ad43a55da71250eee81ff7aedc090a641b4689510f8848f7bad86e76416618b1769b59c59547b2a6ee5f5774b492", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eba0ed3cb305ca5b816cca3c9afb6ee8f6b54ca0cb4a96b24037c063b16d6b5dc1066ca9302ff0ca66320f57b1216533b907ee76abe26657f5f64d81135d763c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e7f0297e2f71c5093adeeba57ff0ec56631e4c179186fc1d376581fc436440e84dd3e610bb93ddc09c45d428304285488ca3fd3d3edd80975c8277df9cbbb929"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-10 21:49:56.202135) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 21:49:56.202474) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1478836985.896748-764878907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 21:49:56.286295) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-10 21:49:56.286688) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-10 21:49:56.287021) ========= ========= Total master_lag: 0.17 =========