builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-019 starttime: 1480612313.67 results: success (0) buildid: 20161201063537 builduid: d1fc110a75b84041badb049e6cd75a8a revision: 81a44d9e587f565128236c700f662cb6ab81b205 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 09:11:53.674756) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 09:11:53.675282) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 09:11:53.675635) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 09:11:53.690954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 09:11:53.691435) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-01 09:11:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-12-01 09:11:53 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105758 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 09:11:53.811690) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 09:11:53.812119) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018328 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 09:11:53.862117) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 09:11:53.862470) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 81a44d9e587f565128236c700f662cb6ab81b205 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 81a44d9e587f565128236c700f662cb6ab81b205 --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=78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-01 09:11:54,023 truncating revision to first 12 chars 2016-12-01 09:11:54,023 Setting DEBUG logging. 2016-12-01 09:11:54,023 attempt 1/10 2016-12-01 09:11:54,023 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/81a44d9e587f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-01 09:11:54,353 unpacking tar archive at: mozilla-aurora-81a44d9e587f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.670129 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 09:11:54.546133) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 09:11:54.546444) ========= script_repo_revision: 81a44d9e587f565128236c700f662cb6ab81b205 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 09:11:54.546833) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 09:11:54.547154) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 09:11:54.558263) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-12-01 09:11:54.558665) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:11:54 INFO - MultiFileLogger online at 20161201 09:11:54 in /builds/slave/test 09:11:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:11:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:11:54 INFO - {'append_to_log': False, 09:11:54 INFO - 'base_work_dir': '/builds/slave/test', 09:11:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:11:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:11:54 INFO - 'branch': 'Mozilla-Aurora', 09:11:54 INFO - 'buildbot_json_path': 'buildprops.json', 09:11:54 INFO - 'config_files': ('talos/linux_config.py',), 09:11:54 INFO - 'default_actions': ('clobber', 09:11:54 INFO - 'read-buildbot-config', 09:11:54 INFO - 'download-and-extract', 09:11:54 INFO - 'populate-webroot', 09:11:54 INFO - 'create-virtualenv', 09:11:54 INFO - 'install', 09:11:54 INFO - 'run-tests'), 09:11:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:11:54 INFO - 'download_minidump_stackwalk': True, 09:11:54 INFO - 'download_symbols': 'ondemand', 09:11:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:11:54 INFO - 'tooltool.py': '/tools/tooltool.py', 09:11:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:11:54 INFO - '/tools/misc-python/virtualenv.py')}, 09:11:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:11:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:11:54 INFO - 'installer_path': 'installer.exe', 09:11:54 INFO - 'log_level': 'info', 09:11:54 INFO - 'log_name': 'talos', 09:11:54 INFO - 'log_to_console': True, 09:11:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:11:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:11:54 INFO - 'opt_config_files': (), 09:11:54 INFO - 'pip_index': False, 09:11:54 INFO - 'sps_profile': False, 09:11:54 INFO - 'sps_profile_interval': 0, 09:11:54 INFO - 'suite': 'dromaeojs-e10s', 09:11:54 INFO - 'system_bits': '32', 09:11:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:11:54 INFO - 'title': 'talos-linux64-ix-019', 09:11:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:11:54 INFO - 'use_talos_json': True, 09:11:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:11:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:11:54 INFO - 'work_dir': 'build'} 09:11:54 INFO - [mozharness: 2016-12-01 17:11:54.828674Z] Running clobber step. 09:11:54 INFO - Running pre-action listener: _resource_record_pre_action 09:11:54 INFO - Running main action method: clobber 09:11:54 INFO - rmtree: /builds/slave/test/build 09:11:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:11:55 INFO - Running post-action listener: _resource_record_post_action 09:11:55 INFO - [mozharness: 2016-12-01 17:11:55.811856Z] Finished clobber step (success) 09:11:55 INFO - [mozharness: 2016-12-01 17:11:55.811955Z] Running read-buildbot-config step. 09:11:55 INFO - Running pre-action listener: _resource_record_pre_action 09:11:55 INFO - Running main action method: read_buildbot_config 09:11:55 INFO - Using buildbot properties: 09:11:55 INFO - { 09:11:55 INFO - "project": "", 09:11:55 INFO - "product": "firefox", 09:11:55 INFO - "script_repo_revision": "production", 09:11:55 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:11:55 INFO - "repository": "", 09:11:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:11:55 INFO - "buildid": "20161201063537", 09:11:55 INFO - "pgo_build": "True", 09:11:55 INFO - "basedir": "/builds/slave/test", 09:11:55 INFO - "buildnumber": 686, 09:11:55 INFO - "slavename": "talos-linux64-ix-019", 09:11:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:11:55 INFO - "platform": "ubuntu64_hw", 09:11:55 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:11:55 INFO - "branch": "mozilla-aurora", 09:11:55 INFO - "repo_path": "releases/mozilla-aurora", 09:11:55 INFO - "revision": "81a44d9e587f565128236c700f662cb6ab81b205", 09:11:55 INFO - "stage_platform": "linux64-pgo", 09:11:55 INFO - "builduid": "d1fc110a75b84041badb049e6cd75a8a", 09:11:55 INFO - "slavebuilddir": "test" 09:11:55 INFO - } 09:11:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 09:11:55 INFO - Running post-action listener: _resource_record_post_action 09:11:55 INFO - [mozharness: 2016-12-01 17:11:55.814386Z] Finished read-buildbot-config step (success) 09:11:55 INFO - [mozharness: 2016-12-01 17:11:55.814475Z] Running download-and-extract step. 09:11:55 INFO - Running pre-action listener: _resource_record_pre_action 09:11:55 INFO - Running main action method: download_and_extract 09:11:55 INFO - mkdir: /builds/slave/test/build/tests 09:11:55 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')]} 09:11:55 INFO - trying https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:11:55 INFO - Downloading https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:11:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:11:56 INFO - Downloaded 1361 bytes. 09:11:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:11:56 INFO - Using the following test package requirements: 09:11:56 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:11:56 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:11:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:11:56 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:11:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:11:56 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:11:56 INFO - u'jsshell-linux-x86_64.zip'], 09:11:56 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:11:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:11:56 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:11:56 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:11:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:11:56 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:11:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:11:56 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:11:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:11:56 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:11:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:11:56 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:11:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:11:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:11:56 INFO - Fetch https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:11:57 INFO - Http code: 200 09:11:57 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 09:11:57 INFO - x-amz-cf-id: lcQK9fhyMTgFqZuAoYSuEqM9SMBR0jPMBHlefUI0MgAqTeuvDlODEA== 09:11:57 INFO - x-amz-version-id: Qpyvkgcs8e1Of9NHx9HUaS2B_S43NQ_L 09:11:58 INFO - Expected file size: 21958343 09:11:58 INFO - Obtained file size: 21958343 09:12:02 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:12:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:12:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:12:02 INFO - Fetch https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:12:02 INFO - Http code: 200 09:12:02 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 09:12:02 INFO - x-amz-cf-id: Wy6gS8M6lRhlCM8VStQSgXl4NKwnAPT6I-XWttAj3dDsTPdjHrcBCg== 09:12:02 INFO - x-amz-version-id: Qpyvkgcs8e1Of9NHx9HUaS2B_S43NQ_L 09:12:03 INFO - Expected file size: 21958343 09:12:03 INFO - Obtained file size: 21958343 09:12:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 09:12:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:12:07 INFO - Fetch https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:12:08 INFO - Http code: 200 09:12:08 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 09:12:08 INFO - x-amz-cf-id: Bblguvs700uHzgPhziOsbXDxLooL5b42DSqsq5DAkT8oFgZJ4Tv2Pw== 09:12:08 INFO - x-amz-version-id: 204JQIvP7MpH7F3pyUrVIzuL70rLRmiV 09:12:09 INFO - Expected file size: 14409038 09:12:09 INFO - Obtained file size: 14409038 09:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:09 INFO - trying https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:12:09 INFO - Downloading https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:12:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:12:11 INFO - Downloaded 63979464 bytes. 09:12:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:12:11 INFO - mkdir: /builds/slave/test/properties 09:12:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:12:11 INFO - Writing to file /builds/slave/test/properties/build_url 09:12:11 INFO - Contents: 09:12:11 INFO - build_url:https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:12:12 INFO - Running post-action listener: _resource_record_post_action 09:12:12 INFO - Running post-action listener: set_extra_try_arguments 09:12:12 INFO - [mozharness: 2016-12-01 17:12:12.281405Z] Finished download-and-extract step (success) 09:12:12 INFO - [mozharness: 2016-12-01 17:12:12.281633Z] Running populate-webroot step. 09:12:12 INFO - Running pre-action listener: _resource_record_pre_action 09:12:12 INFO - Running main action method: populate_webroot 09:12:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:12:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:12:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:12:12 INFO - '--tppagecycles', 09:12:12 INFO - '7'], 09:12:12 INFO - 'tests': ['tsvgm']}}, 09:12:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:12:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:12:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:12:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:12:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:12:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:12:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:12 INFO - 'talos_options': ['--disable-e10s'], 09:12:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:12:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:12:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:12 INFO - 'talos_options': ['--disable-e10s'], 09:12:12 INFO - 'tests': ['damp', 'tps']}, 09:12:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:12 INFO - 'tests': ['damp', 'tps']}, 09:12:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:12:12 INFO - 'tests': ['dromaeo_dom']}, 09:12:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:12:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:12:12 INFO - 'tests': ['basic_compositor_video']}, 09:12:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:12:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:12:12 INFO - 'tests': ['a11yr', 09:12:12 INFO - 'ts_paint', 09:12:12 INFO - 'tpaint', 09:12:12 INFO - 'sessionrestore', 09:12:12 INFO - 'sessionrestore_no_auto_restore', 09:12:12 INFO - 'tabpaint']}, 09:12:12 INFO - 'other-e10s': {'tests': ['a11yr', 09:12:12 INFO - 'ts_paint', 09:12:12 INFO - 'tpaint', 09:12:12 INFO - 'sessionrestore', 09:12:12 INFO - 'sessionrestore_no_auto_restore', 09:12:12 INFO - 'tabpaint']}, 09:12:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:12:12 INFO - 'ts_paint', 09:12:12 INFO - 'tpaint', 09:12:12 INFO - 'sessionrestore', 09:12:12 INFO - 'sessionrestore_no_auto_restore', 09:12:12 INFO - 'tabpaint']}, 09:12:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:12:12 INFO - 'ts_paint', 09:12:12 INFO - 'tpaint', 09:12:12 INFO - 'sessionrestore', 09:12:12 INFO - 'sessionrestore_no_auto_restore', 09:12:12 INFO - 'tabpaint']}, 09:12:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:12:12 INFO - 'tests': ['a11yr', 09:12:12 INFO - 'ts_paint', 09:12:12 INFO - 'tpaint', 09:12:12 INFO - 'sessionrestore', 09:12:12 INFO - 'sessionrestore_no_auto_restore', 09:12:12 INFO - 'tabpaint']}, 09:12:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:12:12 INFO - 'tests': ['a11yr', 09:12:12 INFO - 'ts_paint', 09:12:12 INFO - 'tpaint', 09:12:12 INFO - 'sessionrestore', 09:12:12 INFO - 'sessionrestore_no_auto_restore', 09:12:12 INFO - 'tabpaint']}, 09:12:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:12:12 INFO - 'tests': ['tsvgx', 09:12:12 INFO - 'tsvgr_opacity', 09:12:12 INFO - 'tart', 09:12:12 INFO - 'tscrollx', 09:12:12 INFO - 'cart']}, 09:12:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:12:12 INFO - 'tsvgr_opacity', 09:12:12 INFO - 'tart', 09:12:12 INFO - 'tscrollx', 09:12:12 INFO - 'cart']}, 09:12:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:12 INFO - 'talos_options': ['--disable-e10s'], 09:12:12 INFO - 'tests': ['tp5o']}, 09:12:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:12 INFO - 'tests': ['tp5o']}, 09:12:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:12 INFO - 'talos_options': ['--disable-e10s', 09:12:12 INFO - '--xperf_path', 09:12:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:12:12 INFO - 'tests': ['tp5n']}, 09:12:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:12 INFO - 'talos_options': ['--xperf_path', 09:12:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:12:12 INFO - 'tests': ['tp5n']}}, 09:12:12 INFO - 'talos.zip': {'path': '', 09:12:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:12:12 INFO - Running post-action listener: _resource_record_post_action 09:12:12 INFO - [mozharness: 2016-12-01 17:12:12.298624Z] Finished populate-webroot step (success) 09:12:12 INFO - [mozharness: 2016-12-01 17:12:12.298713Z] Running create-virtualenv step. 09:12:12 INFO - Running pre-action listener: _resource_record_pre_action 09:12:12 INFO - Running main action method: create_virtualenv 09:12:12 INFO - Creating virtualenv /builds/slave/test/build/venv 09:12:12 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 09:12:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:12:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:12:12 INFO - Using real prefix '/usr' 09:12:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:12:12 INFO - Installing distribute.............................................................................................................................................................................................done. 09:12:14 INFO - Installing pip.................done. 09:12:14 INFO - Return code: 0 09:12:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:12:15 INFO - Reading from file tmpfile_stdout 09:12:15 INFO - Output received: 09:12:15 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) 09:12:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe30ff19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c00ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfdf60>, '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 0x2bfed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bff1d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381', '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 09:12:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:12:15 INFO - Using env: {'DISPLAY': ':0', 09:12:15 INFO - 'HOME': '/home/cltbld', 09:12:15 INFO - 'LANG': 'en_US.UTF-8', 09:12:15 INFO - 'LANGUAGE': 'en_US:en', 09:12:15 INFO - 'LOGNAME': 'cltbld', 09:12:15 INFO - 'MAIL': '/var/mail/cltbld', 09:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:15 INFO - 'MOZ_NO_REMOTE': '1', 09:12:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:15 INFO - 'NO_EM_RESTART': '1', 09:12:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:15 INFO - 'PWD': '/builds/slave/test', 09:12:15 INFO - 'SHELL': '/bin/bash', 09:12:15 INFO - 'SHLVL': '1', 09:12:15 INFO - 'TERM': 'linux', 09:12:15 INFO - 'TMOUT': '86400', 09:12:15 INFO - 'USER': 'cltbld', 09:12:15 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381', 09:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:15 INFO - '_': '/tools/buildbot/bin/python'} 09:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:15 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 09:12:15 INFO - Cleaning up... 09:12:15 INFO - Return code: 0 09:12:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe30ff19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c00ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfdf60>, '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 0x2bfed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bff1d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381', '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 09:12:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:12:15 INFO - Using env: {'DISPLAY': ':0', 09:12:15 INFO - 'HOME': '/home/cltbld', 09:12:15 INFO - 'LANG': 'en_US.UTF-8', 09:12:15 INFO - 'LANGUAGE': 'en_US:en', 09:12:15 INFO - 'LOGNAME': 'cltbld', 09:12:15 INFO - 'MAIL': '/var/mail/cltbld', 09:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:15 INFO - 'MOZ_NO_REMOTE': '1', 09:12:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:15 INFO - 'NO_EM_RESTART': '1', 09:12:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:15 INFO - 'PWD': '/builds/slave/test', 09:12:15 INFO - 'SHELL': '/bin/bash', 09:12:15 INFO - 'SHLVL': '1', 09:12:15 INFO - 'TERM': 'linux', 09:12:15 INFO - 'TMOUT': '86400', 09:12:15 INFO - 'USER': 'cltbld', 09:12:15 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381', 09:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:15 INFO - '_': '/tools/buildbot/bin/python'} 09:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:15 INFO - Downloading/unpacking psutil>=3.1.1 09:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:12:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:12:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:12:17 INFO - Installing collected packages: psutil 09:12:17 INFO - Running setup.py install for psutil 09:12:17 INFO - building 'psutil._psutil_linux' extension 09:12:17 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 09:12:17 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 09:12:17 INFO - building 'psutil._psutil_posix' extension 09:12:17 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 09:12:18 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 09:12:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:12:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:12:18 INFO - Successfully installed psutil 09:12:18 INFO - Cleaning up... 09:12:18 INFO - Return code: 0 09:12:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:12: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')]} 09:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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')]} 09:12:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:18 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 0x7fe30ff19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c00ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfdf60>, '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 0x2bfed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bff1d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381', '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 09:12:18 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 09:12:18 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 09:12:18 INFO - Using env: {'DISPLAY': ':0', 09:12:18 INFO - 'HOME': '/home/cltbld', 09:12:18 INFO - 'LANG': 'en_US.UTF-8', 09:12:18 INFO - 'LANGUAGE': 'en_US:en', 09:12:18 INFO - 'LOGNAME': 'cltbld', 09:12:18 INFO - 'MAIL': '/var/mail/cltbld', 09:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:18 INFO - 'MOZ_NO_REMOTE': '1', 09:12:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:18 INFO - 'NO_EM_RESTART': '1', 09:12:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:18 INFO - 'PWD': '/builds/slave/test', 09:12:18 INFO - 'SHELL': '/bin/bash', 09:12:18 INFO - 'SHLVL': '1', 09:12:18 INFO - 'TERM': 'linux', 09:12:18 INFO - 'TMOUT': '86400', 09:12:18 INFO - 'USER': 'cltbld', 09:12:18 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381', 09:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:18 INFO - '_': '/tools/buildbot/bin/python'} 09:12:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:12:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:12:20 INFO - Installing collected packages: mozsystemmonitor 09:12:20 INFO - Running setup.py install for mozsystemmonitor 09:12:20 INFO - Successfully installed mozsystemmonitor 09:12:20 INFO - Cleaning up... 09:12:20 INFO - Return code: 0 09:12:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe30ff19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c00ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfdf60>, '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 0x2bfed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bff1d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381', '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 09:12:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:12:20 INFO - Using env: {'DISPLAY': ':0', 09:12:20 INFO - 'HOME': '/home/cltbld', 09:12:20 INFO - 'LANG': 'en_US.UTF-8', 09:12:20 INFO - 'LANGUAGE': 'en_US:en', 09:12:20 INFO - 'LOGNAME': 'cltbld', 09:12:20 INFO - 'MAIL': '/var/mail/cltbld', 09:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:20 INFO - 'MOZ_NO_REMOTE': '1', 09:12:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:20 INFO - 'NO_EM_RESTART': '1', 09:12:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:20 INFO - 'PWD': '/builds/slave/test', 09:12:20 INFO - 'SHELL': '/bin/bash', 09:12:20 INFO - 'SHLVL': '1', 09:12:20 INFO - 'TERM': 'linux', 09:12:20 INFO - 'TMOUT': '86400', 09:12:20 INFO - 'USER': 'cltbld', 09:12:20 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381', 09:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:20 INFO - '_': '/tools/buildbot/bin/python'} 09:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:20 INFO - Downloading/unpacking jsonschema==2.5.1 09:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:12:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:12:22 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 09:12:22 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 09:12:22 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 09:12:22 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 09:12:22 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 09:12:22 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 09:12:22 INFO - Downloading functools32-3.2.3-2.tar.gz 09:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:12:23 INFO - warning: no files found matching '*.txt' 09:12:23 INFO - no previously-included directories found matching 'build' 09:12:23 INFO - no previously-included directories found matching 'dist' 09:12:23 INFO - no previously-included directories found matching '.git*' 09:12:23 INFO - Installing collected packages: jsonschema, functools32 09:12:23 INFO - Running setup.py install for functools32 09:12:23 INFO - warning: no files found matching '*.txt' 09:12:23 INFO - no previously-included directories found matching 'build' 09:12:23 INFO - no previously-included directories found matching 'dist' 09:12:23 INFO - no previously-included directories found matching '.git*' 09:12:23 INFO - Successfully installed jsonschema functools32 09:12:23 INFO - Cleaning up... 09:12:23 INFO - Return code: 0 09:12:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:23 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 0x7fe30ff19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c00ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfdf60>, '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 0x2bfed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bff1d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381', '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 09:12:23 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 09:12:23 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 09:12:23 INFO - Using env: {'DISPLAY': ':0', 09:12:23 INFO - 'HOME': '/home/cltbld', 09:12:23 INFO - 'LANG': 'en_US.UTF-8', 09:12:23 INFO - 'LANGUAGE': 'en_US:en', 09:12:23 INFO - 'LOGNAME': 'cltbld', 09:12:23 INFO - 'MAIL': '/var/mail/cltbld', 09:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:23 INFO - 'MOZ_NO_REMOTE': '1', 09:12:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:23 INFO - 'NO_EM_RESTART': '1', 09:12:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:23 INFO - 'PWD': '/builds/slave/test', 09:12:23 INFO - 'SHELL': '/bin/bash', 09:12:23 INFO - 'SHLVL': '1', 09:12:23 INFO - 'TERM': 'linux', 09:12:23 INFO - 'TMOUT': '86400', 09:12:23 INFO - 'USER': 'cltbld', 09:12:23 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381', 09:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:23 INFO - '_': '/tools/buildbot/bin/python'} 09:12:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:12:23 INFO - Cleaning up... 09:12:23 INFO - Return code: 0 09:12:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:23 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 0x7fe30ff19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c00ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfdf60>, '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 0x2bfed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bff1d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381', '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 09:12:23 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 09:12:23 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 09:12:23 INFO - Using env: {'DISPLAY': ':0', 09:12:23 INFO - 'HOME': '/home/cltbld', 09:12:23 INFO - 'LANG': 'en_US.UTF-8', 09:12:23 INFO - 'LANGUAGE': 'en_US:en', 09:12:23 INFO - 'LOGNAME': 'cltbld', 09:12:23 INFO - 'MAIL': '/var/mail/cltbld', 09:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:23 INFO - 'MOZ_NO_REMOTE': '1', 09:12:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:23 INFO - 'NO_EM_RESTART': '1', 09:12:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:23 INFO - 'PWD': '/builds/slave/test', 09:12:23 INFO - 'SHELL': '/bin/bash', 09:12:23 INFO - 'SHLVL': '1', 09:12:23 INFO - 'TERM': 'linux', 09:12:23 INFO - 'TMOUT': '86400', 09:12:23 INFO - 'USER': 'cltbld', 09:12:23 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381', 09:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:23 INFO - '_': '/tools/buildbot/bin/python'} 09:12:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:23 INFO - Downloading/unpacking blobuploader==1.2.4 09:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:25 INFO - Downloading blobuploader-1.2.4.tar.gz 09:12:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:12:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:12:25 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 09:12:25 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 09:12:25 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 09:12:25 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 09:12:25 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 09:12:25 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 09:12:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:12:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:12:26 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 09:12:26 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 09:12:26 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 09:12:26 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 09:12:26 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 09:12:26 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 09:12:26 INFO - Downloading docopt-0.6.1.tar.gz 09:12:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:12:26 INFO - Installing collected packages: blobuploader, requests, docopt 09:12:26 INFO - Running setup.py install for blobuploader 09:12:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:12:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:12:26 INFO - Running setup.py install for requests 09:12:26 INFO - Running setup.py install for docopt 09:12:27 INFO - Successfully installed blobuploader requests docopt 09:12:27 INFO - Cleaning up... 09:12:27 INFO - Return code: 0 09:12:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:27 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 0x7fe30ff19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c00ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfdf60>, '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 0x2bfed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bff1d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381', '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 09:12:27 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 09:12:27 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 09:12:27 INFO - Using env: {'DISPLAY': ':0', 09:12:27 INFO - 'HOME': '/home/cltbld', 09:12:27 INFO - 'LANG': 'en_US.UTF-8', 09:12:27 INFO - 'LANGUAGE': 'en_US:en', 09:12:27 INFO - 'LOGNAME': 'cltbld', 09:12:27 INFO - 'MAIL': '/var/mail/cltbld', 09:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:27 INFO - 'MOZ_NO_REMOTE': '1', 09:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:27 INFO - 'NO_EM_RESTART': '1', 09:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:27 INFO - 'PWD': '/builds/slave/test', 09:12:27 INFO - 'SHELL': '/bin/bash', 09:12:27 INFO - 'SHLVL': '1', 09:12:27 INFO - 'TERM': 'linux', 09:12:27 INFO - 'TMOUT': '86400', 09:12:27 INFO - 'USER': 'cltbld', 09:12:27 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381', 09:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:27 INFO - '_': '/tools/buildbot/bin/python'} 09:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:12:27 INFO - Running setup.py (path:/tmp/pip-6ZhZ06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:12:27 INFO - Running setup.py (path:/tmp/pip-sobuIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:12:27 INFO - Running setup.py (path:/tmp/pip-95VXIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:12:27 INFO - Running setup.py (path:/tmp/pip-xGovau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:12:27 INFO - Running setup.py (path:/tmp/pip-Bzpixg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:12:27 INFO - Running setup.py (path:/tmp/pip-EWL2qW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:12:27 INFO - Running setup.py (path:/tmp/pip-R1lWGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:12:27 INFO - Running setup.py (path:/tmp/pip-aibFsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:12:27 INFO - Running setup.py (path:/tmp/pip-F7VvqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:12:28 INFO - Running setup.py (path:/tmp/pip-6XKLuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:12:28 INFO - Running setup.py (path:/tmp/pip-PaKZ2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:12:28 INFO - Running setup.py (path:/tmp/pip-Hhgq4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:12:28 INFO - Running setup.py (path:/tmp/pip-BdFr0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:12:28 INFO - Running setup.py (path:/tmp/pip-XmoeV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:28 INFO - Running setup.py (path:/tmp/pip-5yYsUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:12:28 INFO - Running setup.py (path:/tmp/pip-gaaKey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:12:28 INFO - Running setup.py (path:/tmp/pip-lCFix5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:12:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:12:28 INFO - Running setup.py install for manifestparser 09:12:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:12:28 INFO - Running setup.py install for mozcrash 09:12:28 INFO - Running setup.py install for mozdebug 09:12:28 INFO - Running setup.py install for mozdevice 09:12:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:12:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:12:29 INFO - Running setup.py install for mozfile 09:12:29 INFO - Running setup.py install for mozhttpd 09:12:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:12:29 INFO - Running setup.py install for mozinfo 09:12:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:12:29 INFO - Running setup.py install for mozInstall 09:12:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:12:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:12:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:12:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:12:29 INFO - Running setup.py install for mozleak 09:12:29 INFO - Running setup.py install for mozlog 09:12:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:12:29 INFO - Running setup.py install for moznetwork 09:12:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:12:29 INFO - Running setup.py install for mozprocess 09:12:29 INFO - Running setup.py install for mozprofile 09:12:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:12:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:12:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:12:29 INFO - Running setup.py install for mozrunner 09:12:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:12:30 INFO - Running setup.py install for mozscreenshot 09:12:30 INFO - Running setup.py install for moztest 09:12:30 INFO - Running setup.py install for mozversion 09:12:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:12:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:12:30 INFO - Cleaning up... 09:12:30 INFO - Return code: 0 09:12:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12: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')]} 09:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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')]} 09:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:30 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 0x7fe30ff19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c00ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfdf60>, '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 0x2bfed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bff1d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381', '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 09:12:30 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 09:12:30 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 09:12:30 INFO - Using env: {'DISPLAY': ':0', 09:12:30 INFO - 'HOME': '/home/cltbld', 09:12:30 INFO - 'LANG': 'en_US.UTF-8', 09:12:30 INFO - 'LANGUAGE': 'en_US:en', 09:12:30 INFO - 'LOGNAME': 'cltbld', 09:12:30 INFO - 'MAIL': '/var/mail/cltbld', 09:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:30 INFO - 'MOZ_NO_REMOTE': '1', 09:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:30 INFO - 'NO_EM_RESTART': '1', 09:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:30 INFO - 'PWD': '/builds/slave/test', 09:12:30 INFO - 'SHELL': '/bin/bash', 09:12:30 INFO - 'SHLVL': '1', 09:12:30 INFO - 'TERM': 'linux', 09:12:30 INFO - 'TMOUT': '86400', 09:12:30 INFO - 'USER': 'cltbld', 09:12:30 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381', 09:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:30 INFO - '_': '/tools/buildbot/bin/python'} 09:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:12:30 INFO - Running setup.py (path:/tmp/pip-0L3SXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:12:30 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)) 09:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:12:30 INFO - Running setup.py (path:/tmp/pip-Mfag2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:12:30 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)) 09:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:12:30 INFO - Running setup.py (path:/tmp/pip-Bl31zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:12:30 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)) 09:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:12:30 INFO - Running setup.py (path:/tmp/pip-WAZV1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:12:30 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)) 09:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:12:30 INFO - Running setup.py (path:/tmp/pip-Dnvwy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:12:31 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)) 09:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:12:31 INFO - Running setup.py (path:/tmp/pip-5N6Fd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:12:31 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)) 09:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:12:31 INFO - Running setup.py (path:/tmp/pip-RyWkSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:12:31 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)) 09:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:12:31 INFO - Running setup.py (path:/tmp/pip-QF6oG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:12:31 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)) 09:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:12:31 INFO - Running setup.py (path:/tmp/pip-dgv3lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:12:31 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)) 09:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:12:31 INFO - Running setup.py (path:/tmp/pip-s1dPef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:12:31 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)) 09:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:12:31 INFO - Running setup.py (path:/tmp/pip-aiRsGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:12:31 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)) 09:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:12:31 INFO - Running setup.py (path:/tmp/pip-VLOTMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:12:31 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)) 09:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:12:31 INFO - Running setup.py (path:/tmp/pip-GZeNFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:12:31 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)) 09:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:12:31 INFO - Running setup.py (path:/tmp/pip-N1bCjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:12:31 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)) 09:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:31 INFO - Running setup.py (path:/tmp/pip-DeKadp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:31 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)) 09:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:12:31 INFO - Running setup.py (path:/tmp/pip-tB3WD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:12:31 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)) 09:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:12:31 INFO - Running setup.py (path:/tmp/pip-hcAGKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:12:31 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)) 09:12:31 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)) 09:12:31 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)) 09:12:31 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)) 09:12:31 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)) 09:12:31 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)) 09:12:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:12:31 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 09:12:31 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 09:12:31 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 09:12:31 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 09:12:31 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 09:12:31 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 09:12:33 INFO - Downloading blessings-1.6.tar.gz 09:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:12:33 INFO - Installing collected packages: blessings 09:12:33 INFO - Running setup.py install for blessings 09:12:34 INFO - Successfully installed blessings 09:12:34 INFO - Cleaning up... 09:12:34 INFO - Return code: 0 09:12:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:12:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:12:34 INFO - Reading from file tmpfile_stdout 09:12:34 INFO - Current package versions: 09:12:34 INFO - argparse == 1.2.1 09:12:34 INFO - blessings == 1.6 09:12:34 INFO - blobuploader == 1.2.4 09:12:34 INFO - docopt == 0.6.1 09:12:34 INFO - functools32 == 3.2.3-2 09:12:34 INFO - jsonschema == 2.5.1 09:12:34 INFO - manifestparser == 1.1 09:12:34 INFO - mozInstall == 1.12 09:12:34 INFO - mozcrash == 1.0 09:12:34 INFO - mozdebug == 0.1 09:12:34 INFO - mozdevice == 0.48 09:12:34 INFO - mozfile == 1.2 09:12:34 INFO - mozhttpd == 0.7 09:12:34 INFO - mozinfo == 0.9 09:12:34 INFO - mozleak == 0.1 09:12:34 INFO - mozlog == 3.4 09:12:34 INFO - moznetwork == 0.27 09:12:34 INFO - mozprocess == 0.23 09:12:34 INFO - mozprofile == 0.28 09:12:34 INFO - mozrunner == 6.13 09:12:34 INFO - mozscreenshot == 0.1 09:12:34 INFO - mozsystemmonitor == 0.3 09:12:34 INFO - moztest == 0.7 09:12:34 INFO - mozversion == 1.4 09:12:34 INFO - psutil == 3.1.1 09:12:34 INFO - requests == 1.2.3 09:12:34 INFO - wsgiref == 0.1.2 09:12:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12: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')]} 09:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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')]} 09:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:34 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 0x7fe30ff19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c00ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfdf60>, '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 0x2bfed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bff1d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381', '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 09:12:34 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 09:12:34 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 09:12:34 INFO - Using env: {'DISPLAY': ':0', 09:12:34 INFO - 'HOME': '/home/cltbld', 09:12:34 INFO - 'LANG': 'en_US.UTF-8', 09:12:34 INFO - 'LANGUAGE': 'en_US:en', 09:12:34 INFO - 'LOGNAME': 'cltbld', 09:12:34 INFO - 'MAIL': '/var/mail/cltbld', 09:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:34 INFO - 'MOZ_NO_REMOTE': '1', 09:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:34 INFO - 'NO_EM_RESTART': '1', 09:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:34 INFO - 'PWD': '/builds/slave/test', 09:12:34 INFO - 'SHELL': '/bin/bash', 09:12:34 INFO - 'SHLVL': '1', 09:12:34 INFO - 'TERM': 'linux', 09:12:34 INFO - 'TMOUT': '86400', 09:12:34 INFO - 'USER': 'cltbld', 09:12:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381', 09:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:34 INFO - '_': '/tools/buildbot/bin/python'} 09:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:34 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)) 09:12:34 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)) 09:12:34 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)) 09:12:34 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)) 09:12:34 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)) 09:12:34 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)) 09:12:34 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)) 09:12:34 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)) 09:12:34 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)) 09:12:34 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)) 09:12:34 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)) 09:12:34 INFO - Cleaning up... 09:12:34 INFO - Return code: 0 09:12:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:12: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')]} 09:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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')]} 09:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe30ff19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c00ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfdf60>, '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 0x2bfed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bff1d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381', '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 09:12: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', 'jsonschema'] in /builds/slave/test/build 09:12: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 jsonschema 09:12:34 INFO - Using env: {'DISPLAY': ':0', 09:12:34 INFO - 'HOME': '/home/cltbld', 09:12:34 INFO - 'LANG': 'en_US.UTF-8', 09:12:34 INFO - 'LANGUAGE': 'en_US:en', 09:12:34 INFO - 'LOGNAME': 'cltbld', 09:12:34 INFO - 'MAIL': '/var/mail/cltbld', 09:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:34 INFO - 'MOZ_NO_REMOTE': '1', 09:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:34 INFO - 'NO_EM_RESTART': '1', 09:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:34 INFO - 'PWD': '/builds/slave/test', 09:12:34 INFO - 'SHELL': '/bin/bash', 09:12:34 INFO - 'SHLVL': '1', 09:12:34 INFO - 'TERM': 'linux', 09:12:34 INFO - 'TMOUT': '86400', 09:12:34 INFO - 'USER': 'cltbld', 09:12:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381', 09:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:34 INFO - '_': '/tools/buildbot/bin/python'} 09:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:12:34 INFO - Cleaning up... 09:12:34 INFO - Return code: 0 09:12:34 INFO - Running post-action listener: _resource_record_post_action 09:12:34 INFO - Running post-action listener: _start_resource_monitoring 09:12:34 INFO - Starting resource monitoring. 09:12:34 INFO - [mozharness: 2016-12-01 17:12:34.863253Z] Finished create-virtualenv step (success) 09:12:34 INFO - [mozharness: 2016-12-01 17:12:34.863736Z] Running install step. 09:12:34 INFO - Running pre-action listener: _resource_record_pre_action 09:12:34 INFO - Running main action method: install 09:12:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:12:35 INFO - Reading from file tmpfile_stdout 09:12:35 INFO - Detecting whether we're running mozinstall >=1.0... 09:12:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:12:35 INFO - Reading from file tmpfile_stdout 09:12:35 INFO - Output received: 09:12:35 INFO - Usage: mozinstall [options] installer 09:12:35 INFO - Options: 09:12:35 INFO - -h, --help show this help message and exit 09:12:35 INFO - -d DEST, --destination=DEST 09:12:35 INFO - Directory to install application into. [default: 09:12:35 INFO - "/builds/slave/test"] 09:12:35 INFO - --app=APP Application being installed. [default: firefox] 09:12:35 INFO - mkdir: /builds/slave/test/build/application 09:12:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:12:51 INFO - Reading from file tmpfile_stdout 09:12:51 INFO - Output received: 09:12:51 INFO - /builds/slave/test/build/application/firefox/firefox 09:12:51 INFO - Running post-action listener: _resource_record_post_action 09:12:51 INFO - [mozharness: 2016-12-01 17:12:51.085017Z] Finished install step (success) 09:12:51 INFO - [mozharness: 2016-12-01 17:12:51.085260Z] Running run-tests step. 09:12:51 INFO - Running pre-action listener: _resource_record_pre_action 09:12:51 INFO - Running main action method: run_tests 09:12:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:12:51 INFO - Python 2.7.3 09:12:51 INFO - Return code: 0 09:12:51 INFO - grabbing minidump binary from tooltool 09:12:51 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')]} 09:12:51 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 0x2bfdf60>, '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 0x2bfed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bff1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:12:51 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 09:12:51 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 09:12:51 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 09:12:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:12:51 INFO - Return code: 0 09:12:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:12:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:12:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:12:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:12:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:12:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 09:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 09:12:51 INFO - Using env: {'DISPLAY': ':0', 09:12:51 INFO - 'HOME': '/home/cltbld', 09:12:51 INFO - 'LANG': 'en_US.UTF-8', 09:12:51 INFO - 'LANGUAGE': 'en_US:en', 09:12:51 INFO - 'LOGNAME': 'cltbld', 09:12:51 INFO - 'MAIL': '/var/mail/cltbld', 09:12:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:12:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:51 INFO - 'MOZ_NO_REMOTE': '1', 09:12:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:12:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:51 INFO - 'NO_EM_RESTART': '1', 09:12:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:51 INFO - 'PWD': '/builds/slave/test', 09:12:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:12:51 INFO - 'SHELL': '/bin/bash', 09:12:51 INFO - 'SHLVL': '1', 09:12:51 INFO - 'TERM': 'linux', 09:12:51 INFO - 'TMOUT': '86400', 09:12:51 INFO - 'USER': 'cltbld', 09:12:51 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381', 09:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:51 INFO - '_': '/tools/buildbot/bin/python'} 09:12:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 09:12:51 INFO - mozversion application_buildid: 20161201063537 09:12:51 INFO - mozversion application_changeset: 81a44d9e587f565128236c700f662cb6ab81b205 09:12:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:12:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:12:51 INFO - mozversion application_name: Firefox 09:12:51 INFO - mozversion application_remotingname: firefox-dev 09:12:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:12:51 INFO - mozversion application_vendor: Mozilla 09:12:51 INFO - mozversion application_version: 52.0a2 09:12:51 INFO - mozversion platform_buildid: 20161201063537 09:12:51 INFO - mozversion platform_changeset: 81a44d9e587f565128236c700f662cb6ab81b205 09:12:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:12:51 INFO - mozversion platform_version: 52.0a2 09:12:51 INFO - using testdate: 1480612371 09:12:51 INFO - actual date: 1480612371 09:12:51 INFO - starting webserver on 'localhost:36663' 09:12:51 INFO - SUITE-START | Running 2 tests 09:12:51 INFO - TEST-START | dromaeo_css 09:12:51 INFO - operating with platform_type : linux_ 09:12:51 INFO - Initialising browser for dromaeo_css test... 09:12:51 INFO - TEST-INFO | started process 26233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTIrLP_/profile http://localhost:36663/getInfo.html) 09:12:56 INFO - PROCESS | 26233 | __metrics Screen width/height:1600/1200 09:12:56 INFO - PROCESS | 26233 | colorDepth:24 09:12:56 INFO - PROCESS | 26233 | Browser inner width/height: 1024/697 09:12:56 INFO - PROCESS | 26233 | __metrics 09:12:56 ERROR - PROCESS | 26233 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 09:12:57 INFO - TEST-INFO | 26233: exit 0 09:12:57 INFO - Browser initialized. 09:12:57 INFO - Running cycle 1/1 for dromaeo_css test... 09:12:57 INFO - TEST-INFO | started process 26363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTIrLP_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:09 INFO - PROCESS | 26363 | RSS: Main: 152096768 09:13:09 INFO - PROCESS | 26363 | 09:13:58 INFO - PROCESS | 26363 | 1480612438975 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] 09:16:09 INFO - PROCESS | 26363 | Cycle 1(1): loaded http://localhost:36663/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36663/tests/dromaeo/cssquery-ext.html) 09:16:11 INFO - PROCESS | 26363 | RSS: Main: 157048832 09:16:11 INFO - PROCESS | 26363 | 09:19:13 INFO - PROCESS | 26363 | Cycle 1(1): loaded http://localhost:36663/tests/dromaeo/cssquery-ext.html (next: http://localhost:36663/tests/dromaeo/cssquery-jquery.html) 09:19:13 INFO - PROCESS | 26363 | RSS: Main: 153075712 09:19:13 INFO - PROCESS | 26363 | 09:22:15 INFO - PROCESS | 26363 | Cycle 1(1): loaded http://localhost:36663/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36663/tests/dromaeo/cssquery-mootools.html) 09:22:16 INFO - PROCESS | 26363 | RSS: Main: 153145344 09:22:16 INFO - PROCESS | 26363 | 09:25:18 INFO - PROCESS | 26363 | Cycle 1(1): loaded http://localhost:36663/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36663/tests/dromaeo/cssquery-prototype.html) 09:25:18 INFO - PROCESS | 26363 | RSS: Main: 151834624 09:25:18 INFO - PROCESS | 26363 | 09:28:21 INFO - PROCESS | 26363 | Cycle 1(1): loaded http://localhost:36663/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36663/tests/dromaeo/cssquery-yui.html) 09:28:21 INFO - PROCESS | 26363 | RSS: Main: 154443776 09:28:21 INFO - PROCESS | 26363 | 09:31:24 INFO - PROCESS | 26363 | Cycle 1(1): loaded http://localhost:36663/tests/dromaeo/cssquery-yui.html (next: http://localhost:36663/tests/dromaeo/cssquery-dojo.html) 09:31:24 INFO - PROCESS | 26363 | RSS: Main: 155607040 09:31:24 INFO - PROCESS | 26363 | 09:31:24 INFO - PROCESS | 26363 | __start_tp_report 09:31:24 INFO - PROCESS | 26363 | _x_x_mozilla_page_load 09:31:24 INFO - PROCESS | 26363 | _x_x_mozilla_page_load_details 09:31:24 INFO - PROCESS | 26363 | |i|pagename|runs| 09:31:24 INFO - PROCESS | 26363 | |0;dojo.html;3201.2797120647856;3222.3233121044577;3235.3529294141176;3235.7573182011347;3250.6424293327746;5646.2942132233475;5708.8858222835515;5723.885522289552;5732.570057245707;5742.741576629051;5757.366689664133;5800.593958422912;5800.65196088235;5820.825375238739;5835.445632664901;5224.29472021277;5265.262863199156;5293.68237905725;5300.787968481275;5318.73406329682;5322.65402748822;5327.653702509325;5330.680159190441;5340.786368545254;5354.464553544633;5059.468755780646;5097.770600322994;5279.313689220415;5314.123169676998;5317.9202311965355;5202.557782588466;5231.163013917793;5248.606354523426;5257.185136303879;5295.947040529584;5197.558207552363;5221.6083793715625;5290.497402746733;5296.311479507678;5308.283381743454;5697.487226149667;5737.5983681141915;5755.338136114358;5796.478316951495;5831.475167234969;6011.549133814938;6055;6065.514758819284;6173.660448675321;6176.289726681444;6151.231096112986;6172.814815555541;6219.968900155515;6222.0355844844125;6229.37706229378;5633.57748168889;5663.688497132614;5784.334801497797;5794.5074668653215;5807.332156801979;6216.875662486725;6243.344448832807;6257.937420625826;6337.96831015842;6377.298497165308;6084.4828189603495;6091.42131497507;6092.055731361646;6101.542384321194;6112.327643959161;5993.820185394445;6186.505079593621;6198.0702894566175;6201.596896201732;6206.255249370014;5945.346011938684;6030.155778191057;6057.969710151509;6089.969550152221;6130.948521380002;6125.456844956542;6131.233595800525;6131.662758548323;6168.352323006109;6170.691465426711;4700.083483720641;4725.763711814396;4731;4732.503087175865;4749.216379297446;4061.1674606705556;4092.3247664135083;4093.2018256440306;4111.075008123148;4179.97910010448;5801.12983052537;5810.680412577349;5818.389069147764;5821;5865.530757539386;5920.970395147997;6067.029275315928;6076.5442591805795;6100;6131.816045518642;5684.431556844283;5809.88380232393;5860.648361098262;5860.882782344329;5979.790707325223;5302.8939421212135;5342.679439233659;5350;5375.5162035416215;5390.434004429557;6394.872102558016;6455.289918109004;6457.483401327789;6474.0612611172055;6474.482041436674;6047.123167140828;6057.7879774207695;6176.9073463897175;6189.164462797645;6253.812385628438;6457.3865482779065;6462.612243265419;6471.902921456088;6473.449756770728;6489.4808415325715;6093.786717464867;6121;6125.601835880653;6135.171751813448;6135.723892424762;5987.940120598738;6048.0625503047095;6113.749968914014;6161.630302181883;6237.781677641261;6027.457528822427;6054.3340232575265;6080.635161890301;6088.726007329592;6122.448979591858;6055.2733671957885;6091.7563297467605;6096.481799047131;6121.479674227562;6128.295246046761;5840.795572154954;5873.765049397976;5909.55678324136;6033.849153771191;6040.184575082308;5978.880422391441;6098.817035488943;6105.17580126695;6119.326874043941;6143.201383820075;5876.882462350643;5917.615355001911;5927.347991720993;5941.91087133702;5990.550708696778 09:31:24 INFO - PROCESS | 26363 | |1;ext.html;597.4055814464608;638.3999040901554;660.369347273354;679.3342524326164;702.6065403374108;41849.79075104624;45467.772661136645;45487;45506.77246613771;45571.08857822842;45943;46405.30392044122;46464.76767616157;46626;46635.766821165846;8903.73288801337;9000.099990000981;9057.773555661095;9063.818723625523;9077.95461022694;8881.777955551099;9035.503047332393;9061.275097992178;9063.637454501812;9068.410553314014;9014.68448604299;9045.592948317342;9077.909220907772;9105.95447022764;9110.954445227764;8980.101989801;8980.371374003822;9022.233110185642;9024.954875225614;9025.41334813235;8965.103489651048;8988.056254093291;9007.684731034447;9028.819423611556;9048.095190480899;42598.36102458466;43299;43341.349879751826;43484;43516.3472547912;3614.493970844084;3764.9435258471144;3823.541175058983;3826.770393776382;3958.4062390641634;33433.33133337344;33732.49401258983;33800.492992604886;33855.83072084648;34028.6597134028;4526.932096018562;4628.930566041512;4674.906501869978;4686.53134686532;4776.068666610013;362580;365920;366261.1686941575;366871;368118;62982.685086574274;63238.051429228595;63408.68295658584;63478.36521634817;63579.6821015892;67270.32729672738;67312.32687673159;67454;67679;67915;18058.458246252634;18310.633787324445;18316.358927437475;18321.816781832276;18329.633407331778;14114.364853581614;14206.715865682629;14248.073875198286;14303.427862885575;14312.284385780878;17158.477540713924;18280.72578911291;18553.721694174597;18676.06619669011;18897.716534252;6875.5874647521305;6898.379145876795;6971.163460384786;7060.752873649398;7166.570005799668;969.762408209993;1072.4262519552158;1088.6516314779194;1107.9169062320198;1144.2676686920377;32078.35843283168;33639.83180084084;33782.49326260108;33859.492107618404;33913.98258052262;1170.584442522909;1183.5679976808576;1190.8868657477526;1210.939453027345;1289.6775806048488;17736.822631773775;17929.7310540342;18145.63708725818;18315.358962436516;18328.54178645518;142129;143135.2843235777;143164;143372.28313858365;143824;63620.36379636237;63838;64090;64118;64166;1423.252792284059;1426.18707336817;1427.414759948416;1442.6177063078292;1451.5935538049364;31764.205894852814;33155.83422082874;33276.33447331088;33343;33559.83220083884;56147.43852561586;56619.71690141523;56692.433075670364;56720.43279567151;56860.43139568551;441292;442243;446461;446466;447936;43911.121777564906;44359;45560;45856.7707161462;46062.539374607164;50331.496685034144;50997.235041473665;51271.48728512816;51293;52345;42761.572384277;43526.56473435225;44481;45175.0964980692;45277.773611131735;42518.5748142527;42551;43711;44084.00357461994;44442.11115777602;38648.613513865625;39930.80034599808;41990.370144447246;42916.78541607272;44086;38082.2383552333;38627;38920.6107938917;39754;40007.39988900227;29134.56298155572;29619.259518512208;30269.492996157183;30384.84807575948;30438 09:31:24 INFO - PROCESS | 26363 | |2;jquery.html;423.5933503836317;438.30309807406223;441.5209497695001;444.22482767570597;447.219601794868;19219.423417297487;19657.410277691673;19917.502062448428;20634.17463301466;20747.68878466824;19537.90231048846;20262.088206030727;20464.795352046476;20546.48633784156;20701.792982070176;5485.890282194354;5820.912686309709;5825.592208545403;5826.592138550303;5829.300483941933;5541.944580554204;5650.208970744099;5653.378128405892;5717.9714101429645;5725.742341594639;5637.661740295575;5653.378128405872;5670.234518340013;5679.176519404684;5687.345955215141;5671.461211184931;7061.611611361373;7345.522541034816;7378.040854688909;7378.704851805895;6885.793426197222;7122.537035092702;7181.676824542856;7199.028131202325;7220.277972202738;26587.867060664765;26904.192874213804;27397.315067123283;27507.31231719203;27777.583336249972;2557.181701855407;2562.5387430262545;2733.3576609496754;2747.148384000966;3231.806091634486;15631.92184039084;16409.91795041017;16848.326066957306;17079.743803842954;17437.128143592898;2067.958640827175;2167.1873047607146;2194.363634545996;2197.307848027866;2281.9543609127722;102086;106716.4664176682;107033;107164.92835071628;107220.46389768;17225.569360765832;17584.384546541067;17599.20803563843;17677.558061048578;18038.5490362742;31191.376172476423;31366.372672546877;31390.686093138775;31400.685993140232;31616.525752113736;9637.084476974676;9877.40735555869;9974.152197063186;10011.949940250252;10038.247131465168;8268.09051004389;8366.414350995494;8383.371247156487;8420.578971051424;8507.70223042203;8266.8346633067;8455.323574114056;8711.303095752452;8754.387192896564;8755.518446485377;3284.3595498877967;3421.5723034620673;3574.2136729919375;3603.549556305462;3676.889693309205;966.7389804752678;984.8473486609587;993.2848349188718;1008.1884083312857;1091.879893211746;19400.126994285292;19633.803661963484;20005.899970500053;20089.799102009085;20123;1061.6072053340158;1084.1922767538076;1094.6715985204407;1096.4572536594437;1118.6420345489366;10596.788064238672;10990.505427255634;11059.72350691239;11134.387608681438;11147.331160130418;163067;163290.1835490815;166406;166926;167438;54445.72777136168;55052.17421738677;74108.62945685237;81841;89431.55284223537;988.0662773678805;991.5736233419699;1004.4073996342194;1015.2994433840774;1022.5040855185377;17303.702222333122;17654.20556074954;17661.205245764228;19392.4182274532;19541.21835126579;44265.0887810523;44943.77528112339;46238.306425402974;46377.768111159225;47122;59999.70000149971;60073.39926600678;60426.093608596784;60823;61751.38248617636;6325.525585581007;9101.317401195069;9351.766205844908;9414.105659962293;9494.572744226665;13443.46226150943;13729.038967272196;13747.725045499234;13935.372908218951;14104.365303561159;12097.455614497192;12124;12135.393230338272;12224.816627750413;12270.447829847857;11892.881071189524;11927.10546708983;11996.040316774812;12028.939855300667;12162;11929.642110736691;12242.571509997108;12252.203606765532;12308.507659693512;12489.18820276679;8910.242629376575;9285.535723213947;9367.5784589695;9390.295727820578;9603.951980240054;11425.657230283105;12147;12179.573714919936;12647.620571382873;12701.93649031786 09:31:24 INFO - PROCESS | 26363 | |3;mootools.html;1506.9171195584242;1535.7082154390664;1696.5673753192934;1801.9819801801978;1845.8154184581545;7868.213178682129;8019.23817237363;8487.745367638972;9126.406783559063;9127.178553930145;8428.53643049632;8742;8754.474731516098;8868.778280542989;8947.82104357914;2423.7939775119135;2469.9012039518398;2473.2209354053507;2482.577961746498;2490.9128180513685;2403.0507949359994;2477.4549599088173;2503.086373473687;2508.4606809535944;2517.924462266126;2442.426029882985;2456.054419048661;2457.0540341968294;2474.616434452663;2479.47930934504;2368.8815559222057;2381.892814823337;2390.354604256841;2400.3639035655565;2410.3853517353136;2388.0805889732405;2389.2115601851347;2390.497995420964;2414.0343862454984;2418.9395265118337;8745.431546949492;8842.867356989651;8903.955480222558;8915.821683566357;8936.821263574757;5372.167314066326;5474;5531.474509921551;5534.059209934321;5535.972320138414;3450.5859296884532;3455.2053027803745;3488.476728490721;3525.312564050011;3591.317649646559;1188.6731148934025;1222.798238290681;1224.7366816134574;1232.6548566401332;1270.4918032786866;11609.535618575332;11723.472443739967;11751.294922304603;11782.646520604396;11786;4690.668512217946;4777.163996300634;4788.712677239377;4856.8785780355065;4917.483664215206;10459.274219753655;10476.109530689824;10488.475576221159;10507.894921050845;10568.313059651098;5486.259354987105;5498.3127109111365;5500.3949565547755;5506.449355064461;5511.862203444946;4490.438695163105;4606.907861842745;4951.653384263067;4968.205087186105;4996.150654388763;4083.9795801020805;4119.92881850715;4176.644985176234;4200.411942328076;4228.217779710763;1335.6527302901316;1375.2917247617486;1378.951736689211;1384.6676797568512;1388.673661689502;870.9869351959726;961.0437614573405;1005.2711783956573;1031.4997226345217;1049.0296475760044;5872.469877122578;5993.190919225936;6029.60807547508;6202.100695399142;6208.689565521706;476.9833055843029;486.3312944701036;486.8004118311475;490.1373582494835;500.81720172137636;4102.753834769924;4196.118815048813;4196.265653510623;4228.894277643022;4324.891877703019;10730.302530335503;11066.833997490045;11072.833907491395;11162.665120046411;11187.664370068911;11073.335599864035;11100.389478578756;11102.389368584805;11106.222564420414;11115.83326250107;7995.080565735015;8313.833723325499;8325.417220794607;8425.36809739272;8455.788605284917;6119.143319935301;6235.501159907287;6295.118683384421;6312.274088479883;6332.430081292706;10060.84908726355;10181.440020798927;10196.3372380795;10252.179825613784;10256.487175641338;10415.68752937413;10515.158787296845;10545.156387489136;10601.41692206936;10671.786564268827;7392.260773922565;7629.465937384552;7791.220877912164;7800.492967957065;7841.686332546634;8590.312774978112;8896.733098007071;8992.820143597222;9004.189622933967;9004.369694121611;7665.923340766744;7798.727044553413;7834.647440865288;7948.0859701132795;8019.6391162398995;7809.804754881174;7810.218978102144;7847.764567062997;7849.646765895434;8053.395995300259;7145.85708285821;7157.355837974607;7295.927040729737;7368.631568421664;7420.369268612012;5286.180642000496;5300.946990530046;5385.569154467555;5465.453454654503;5562.415946325739;5268.736563171903;5293.920591191212;5324.387695415076;5405.405405405481;5435.972820135874 09:31:24 INFO - PROCESS | 26363 | |4;prototype.html;351.2833819009221;358.5732977756468;360.4143267190815;361.701596183149;366.9541307336583;5814.505767009804;5842.591018628692;5852.414758524145;5874.6181498202695;5875.588708790387;5606.21512988182;5750.367459579454;5765.971170144144;5798.507126894208;5827.348556406835;4481.663875209356;4505.36924830524;4512.39082723833;4519.819207231707;4524.8190072397065;4458.3535387368975;4502;4502.662300327489;4532.297493888453;4546.613537849286;4476.664250181233;4483.50681425043;4483.820647174109;4491.820327186909;4502.527234640348;4322.1473827274;4443.533428989958;4462.464504259509;4480.641548676098;4486.730796152241;4003.8798836034966;4004.3793212051887;4014.6788256939376;4015.4177644241713;4022.155347377054;5556.305461817273;5618.129189975561;5621.173118736427;5622.606417550773;5623.212750214973;5077.26379674945;5100.948990510122;5113.616478764107;5158.74206289684;5174.922376164361;5967.955607768667;5969.104634304846;5973.940260597382;5987.820365389045;5995.310539287994;4337.891552711176;4411.691181617288;4426.03869536766;4426.513083560806;4445.622122119591;5992.352103171619;6206.131141640174;6211.223597050369;6218.689065546704;6265.342139075377;4334.1548398062705;4338.327559228324;4340.717853339586;4373.540778218305;4374.234508960983;4385.640451460057;4425.668074894395;4428.7121337112985;4442.044960333544;4469.754163520973;4960.355153830051;5089.592832573385;5092.898142037213;5104.668196567211;5117.488251174927;6040.697965101727;6053.182820319289;6054.606450580698;6081.391860813972;6081.665508397081;1487.605784467117;1495.2224843081538;1495.7606782914681;1497.670512487251;1511.3123528794372;953.427943234054;1005.5625802775816;1015.8628585140912;1026.8767747870154;1027.5941003303803;5600.52395546375;5602.971985140048;5605.32736071674;5632.676321064547;5651.576131790132;5969;5980.700964951735;5980.700964951735;5993.250843644544;6033.5173186145;5360.517553420211;5518.454832646866;5589.149533737823;5591.658002079553;5632.408597097327;3173.4767311690516;3180.840957952093;3188.72451019594;3191.632962209329;3196.7303214717344;5884.382139875337;6081.695915204311;6218.22272215973;6220.471259942956;6275;5958.761649534057;5991.131285963511;5994.430529099815;6012.428819262163;6034.922189683293;6090.177825993523;6097.237845269341;6123.387201551017;6154.446099851035;6171.210348998829;5807.970960145172;5815;5873.618214816023;5876.500497457764;5914.704264786657;5791.420857914175;5820.650760954356;5834.591578589458;5870.9412905872105;5881.206037184926;6163.229596300463;6222.937770622236;6280.089387038763;6340.207474065742;6431.678416079084;4392.934105988349;4394.890127746704;4399.560043995575;4421.801018954219;4436.667249956202;6073.423024812636;6102.558976409472;6158.876822463615;6222.937770622417;6234.625922444668;5956.523478121827;6020.969895150496;6027.728752206249;6036.426539478743;6056.182415373868;5884.235049443545;5996.640201587918;6024.969875150597;6052.122442245938;6064.878702426015;5933.317668468181;5980.43185897339;5991.7902873399225;5998.970005149947;6045.969770151121;6063.302720187058;6070.785842831539;6083.66539840313;6096.725647345791;6106.755729770759;5780.653160810365;5891.293044834647;5894.55583382057;5936.584439089395;5966.612170208922 09:31:24 INFO - PROCESS | 26363 | |5;yui.html;743.6207534157579;776.6194564663313;799.4284086877881;839.9076101628822;857.661223816592;14152.646183845396;14458.277086145703;14606.415743370266;14690.63273418165;15348.309326080325;14839.406423743038;14916.776248356256;15037.699246015072;15083.170425626586;15087.01934374265;839.1524560194217;849.6856163219618;854.3848429131016;856.4561503445326;861.1603686405767;845.995770021149;848.9769827358019;849.762066621347;850.124371896944;852.6120615120105;888.835565420396;895.5343221524803;898.1871406377206;898.734873212404;899.2356496977582;885.535094075609;889.1597440418807;890.8752774611592;891.5854127830557;892.6429428228696;657.6251536624126;658.8978708300222;659.4032400677347;661.2825084783016;662.6090606542115;13064.477420903153;13065.216087034809;13105.541306054338;13134.802977955338;13135.802962955468;12453.93773031129;12836.743265134739;13055.543055992996;13225.206487610774;13257.46970121194;11243.66269011931;11298.265612735227;11369.545218191262;11376.317420954687;11505.079593632572;3860.5560360558616;3883.436901649245;3948.348522493785;3970.722049456539;3988.641022308006;66591;66931;67190.11621570733;67552;67643.66178169126;9854.359466634645;10064;10079.69760907174;10189.490525473697;10321.277510574188;19798.010099494968;20080.59838803216;20088.69866951997;20121.39635810928;20174.798252017586;8022.237887400687;8154.347652187811;8205.138460461685;8252.33981281496;8502.957485212535;4861.319415281863;4882.609391248691;4924.778384972685;4955.950440495621;5155;3479.460683594047;3614.042278796121;3616.349057169682;3621.6740493355724;3637.8544858205905;631.4948041566728;637.4231320654815;654.4306453385585;655.0796131435341;655.1417642887832;686.4645576450376;778.7897267737792;784.8548018616574;792.9960350198212;816.3061397811931;9819.656312029045;9887.604495820087;10008.649697260707;10231.43727095017;10335.844962325571;670.9463242940553;727.6611035694348;738.8780851159606;781.7498400511781;791.4934441957153;4957.950420495821;5025.899482010413;5072;5085.262636917626;5104.106781313255;92292;94469;95679.52160239154;96167.51916240374;101057.49471252596;74887;76589.61705191438;81112.59443702744;82014.58992705117;87629;47043.76478117587;47356.763216183695;55398.16902746462;58620;64279.35720642827;9526.52367381642;9571.952140239533;9621.615135394506;9722.708318750449;10252.64115755945;49378;49537.50462495329;49844.25233621426;50188.49811501838;51193.7440312796;60927;62315;63037;64753.35246647473;64905.35094648993;13032.348382580643;13183.472661093449;13231.470741170631;13247.80128298057;13362.933185334012;14119.43522259098;14574.85425145735;14678.85321146775;14757.852421475647;15984.760228596813;14170.504032358818;14361.425542978164;14444.927775361057;14471.855281447051;14611.634709132357;12619.242845429304;13290.601281961557;13306.933465332611;13322.467101316226;14867.405303787727;13533.323333833072;13823.447062117804;13863.306834658428;14049.789253161007;14932.925335373253;10460.163186945178;11080.667579972614;11144.777104457704;11151.16366272549;11513.712157195801;11798.764024719629;11858.762824743284;12327.815082773945;12391.194572353128;12591.685207869876 09:31:24 INFO - PROCESS | 26363 | __end_tp_report 09:31:24 INFO - PROCESS | 26363 | __start_cc_report 09:31:24 INFO - PROCESS | 26363 | _x_x_mozilla_cycle_collect,317 09:31:24 INFO - PROCESS | 26363 | __end_cc_report 09:31:24 INFO - PROCESS | 26363 | __startTimestamp1480613484400__endTimestamp 09:31:24 INFO - PROCESS | 26363 | 09:31:24 INFO - PROCESS | 26363 | ------- Summary: start ------- 09:31:24 INFO - PROCESS | 26363 | Number of tests: 6 09:31:24 INFO - PROCESS | 26363 | 09:31:24 INFO - PROCESS | 26363 | [#0] dojo.html Cycles:165 Average:5725.95 Median:5945.35 stddev:667.22 (11.2%) stddev-sans-first:639.19 09:31:24 INFO - PROCESS | 26363 | Values: 3201.3 3222.3 3235.4 3235.8 3250.6 5646.3 5708.9 5723.9 5732.6 5742.7 5757.4 5800.6 5800.7 5820.8 5835.4 5224.3 5265.3 5293.7 5300.8 5318.7 5322.7 5327.7 5330.7 5340.8 5354.5 5059.5 5097.8 5279.3 5314.1 5317.9 5202.6 5231.2 5248.6 5257.2 5295.9 5197.6 5221.6 5290.5 5296.3 5308.3 5697.5 5737.6 5755.3 5796.5 5831.5 6011.5 6055.0 6065.5 6173.7 6176.3 6151.2 6172.8 6220.0 6222.0 6229.4 5633.6 5663.7 5784.3 5794.5 5807.3 6216.9 6243.3 6257.9 6338.0 6377.3 6084.5 6091.4 6092.1 6101.5 6112.3 5993.8 6186.5 6198.1 6201.6 6206.3 5945.3 6030.2 6058.0 6090.0 6130.9 6125.5 6131.2 6131.7 6168.4 6170.7 4700.1 4725.8 4731.0 4732.5 4749.2 4061.2 4092.3 4093.2 4111.1 4180.0 5801.1 5810.7 5818.4 5821.0 5865.5 5921.0 6067.0 6076.5 6100.0 6131.8 5684.4 5809.9 5860.6 5860.9 5979.8 5302.9 5342.7 5350.0 5375.5 5390.4 6394.9 6455.3 6457.5 6474.1 6474.5 6047.1 6057.8 6176.9 6189.2 6253.8 6457.4 6462.6 6471.9 6473.4 6489.5 6093.8 6121.0 6125.6 6135.2 6135.7 5987.9 6048.1 6113.7 6161.6 6237.8 6027.5 6054.3 6080.6 6088.7 6122.4 6055.3 6091.8 6096.5 6121.5 6128.3 5840.8 5873.8 5909.6 6033.8 6040.2 5978.9 6098.8 6105.2 6119.3 6143.2 5876.9 5917.6 5927.3 5941.9 5990.6 09:31:24 INFO - PROCESS | 26363 | 09:31:24 INFO - PROCESS | 26363 | [#1] ext.html Cycles:180 Average:51905.70 Median:44085.00 stddev:90768.97 (205.9%) stddev-sans-first:90941.85 09:31:24 INFO - PROCESS | 26363 | Values: 597.4 638.4 660.4 679.3 702.6 41849.8 45467.8 45487.0 45506.8 45571.1 45943.0 46405.3 46464.8 46626.0 46635.8 8903.7 9000.1 9057.8 9063.8 9078.0 8881.8 9035.5 9061.3 9063.6 9068.4 9014.7 9045.6 9077.9 9106.0 9111.0 8980.1 8980.4 9022.2 9025.0 9025.4 8965.1 8988.1 9007.7 9028.8 9048.1 42598.4 43299.0 43341.3 43484.0 43516.3 3614.5 3764.9 3823.5 3826.8 3958.4 33433.3 33732.5 33800.5 33855.8 34028.7 4526.9 4628.9 4674.9 4686.5 4776.1 362580.0 365920.0 366261.2 366871.0 368118.0 62982.7 63238.1 63408.7 63478.4 63579.7 67270.3 67312.3 67454.0 67679.0 67915.0 18058.5 18310.6 18316.4 18321.8 18329.6 14114.4 14206.7 14248.1 14303.4 14312.3 17158.5 18280.7 18553.7 18676.1 18897.7 6875.6 6898.4 6971.2 7060.8 7166.6 969.8 1072.4 1088.7 1107.9 1144.3 32078.4 33639.8 33782.5 33859.5 33914.0 1170.6 1183.6 1190.9 1210.9 1289.7 17736.8 17929.7 18145.6 18315.4 18328.5 142129.0 143135.3 143164.0 143372.3 143824.0 63620.4 63838.0 64090.0 64118.0 64166.0 1423.3 1426.2 1427.4 1442.6 1451.6 31764.2 33155.8 33276.3 33343.0 33559.8 56147.4 56619.7 56692.4 56720.4 56860.4 441292.0 442243.0 446461.0 446466.0 447936.0 43911.1 44359.0 45560.0 45856.8 46062.5 50331.5 50997.2 51271.5 51293.0 52345.0 42761.6 43526.6 44481.0 45175.1 45277.8 42518.6 42551.0 43711.0 44084.0 44442.1 38648.6 39930.8 41990.4 42916.8 44086.0 38082.2 38627.0 38920.6 39754.0 40007.4 29134.6 29619.3 30269.5 30384.8 30438.0 09:31:24 INFO - PROCESS | 26363 | 09:31:24 INFO - PROCESS | 26363 | [#2] jquery.html Cycles:180 Average:21716.82 Median:14818.78 stddev:32599.25 (220.0%) stddev-sans-first:32651.49 09:31:24 INFO - PROCESS | 26363 | Values: 423.6 438.3 441.5 444.2 447.2 19219.4 19657.4 19917.5 20634.2 20747.7 19537.9 20262.1 20464.8 20546.5 20701.8 5485.9 5820.9 5825.6 5826.6 5829.3 5541.9 5650.2 5653.4 5718.0 5725.7 5637.7 5653.4 5670.2 5679.2 5687.3 5671.5 7061.6 7345.5 7378.0 7378.7 6885.8 7122.5 7181.7 7199.0 7220.3 26587.9 26904.2 27397.3 27507.3 27777.6 2557.2 2562.5 2733.4 2747.1 3231.8 15631.9 16409.9 16848.3 17079.7 17437.1 2068.0 2167.2 2194.4 2197.3 2282.0 102086.0 106716.5 107033.0 107164.9 107220.5 17225.6 17584.4 17599.2 17677.6 18038.5 31191.4 31366.4 31390.7 31400.7 31616.5 9637.1 9877.4 9974.2 10011.9 10038.2 8268.1 8366.4 8383.4 8420.6 8507.7 8266.8 8455.3 8711.3 8754.4 8755.5 3284.4 3421.6 3574.2 3603.5 3676.9 966.7 984.8 993.3 1008.2 1091.9 19400.1 19633.8 20005.9 20089.8 20123.0 1061.6 1084.2 1094.7 1096.5 1118.6 10596.8 10990.5 11059.7 11134.4 11147.3 163067.0 163290.2 166406.0 166926.0 167438.0 54445.7 55052.2 74108.6 81841.0 89431.6 988.1 991.6 1004.4 1015.3 1022.5 17303.7 17654.2 17661.2 19392.4 19541.2 44265.1 44943.8 46238.3 46377.8 47122.0 59999.7 60073.4 60426.1 60823.0 61751.4 6325.5 9101.3 9351.8 9414.1 9494.6 13443.5 13729.0 13747.7 13935.4 14104.4 12097.5 12124.0 12135.4 12224.8 12270.4 11892.9 11927.1 11996.0 12028.9 12162.0 11929.6 12242.6 12252.2 12308.5 12489.2 8910.2 9285.5 9367.6 9390.3 9604.0 11425.7 12147.0 12179.6 12647.6 12701.9 09:31:24 INFO - PROCESS | 26363 | 09:31:24 INFO - PROCESS | 26363 | [#3] mootools.html Cycles:180 Average:5906.80 Median:2583.83 stddev:3297.25 (127.6%) stddev-sans-first:3289.92 09:31:24 INFO - PROCESS | 26363 | Values: 1506.9 1535.7 1696.6 1802.0 1845.8 7868.2 8019.2 8487.7 9126.4 9127.2 8428.5 8742.0 8754.5 8868.8 8947.8 2423.8 2469.9 2473.2 2482.6 2490.9 2403.1 2477.5 2503.1 2508.5 2517.9 2442.4 2456.1 2457.1 2474.6 2479.5 2368.9 2381.9 2390.4 2400.4 2410.4 2388.1 2389.2 2390.5 2414.0 2418.9 8745.4 8842.9 8904.0 8915.8 8936.8 5372.2 5474.0 5531.5 5534.1 5536.0 3450.6 3455.2 3488.5 3525.3 3591.3 1188.7 1222.8 1224.7 1232.7 1270.5 11609.5 11723.5 11751.3 11782.6 11786.0 4690.7 4777.2 4788.7 4856.9 4917.5 10459.3 10476.1 10488.5 10507.9 10568.3 5486.3 5498.3 5500.4 5506.4 5511.9 4490.4 4606.9 4951.7 4968.2 4996.2 4084.0 4119.9 4176.6 4200.4 4228.2 1335.7 1375.3 1379.0 1384.7 1388.7 871.0 961.0 1005.3 1031.5 1049.0 5872.5 5993.2 6029.6 6202.1 6208.7 477.0 486.3 486.8 490.1 500.8 4102.8 4196.1 4196.3 4228.9 4324.9 10730.3 11066.8 11072.8 11162.7 11187.7 11073.3 11100.4 11102.4 11106.2 11115.8 7995.1 8313.8 8325.4 8425.4 8455.8 6119.1 6235.5 6295.1 6312.3 6332.4 10060.8 10181.4 10196.3 10252.2 10256.5 10415.7 10515.2 10545.2 10601.4 10671.8 7392.3 7629.5 7791.2 7800.5 7841.7 8590.3 8896.7 8992.8 9004.2 9004.4 7665.9 7798.7 7834.6 7948.1 8019.6 7809.8 7810.2 7847.8 7849.6 8053.4 7145.9 7157.4 7295.9 7368.6 7420.4 5286.2 5300.9 5385.6 5465.5 5562.4 5268.7 5293.9 5324.4 5405.4 5436.0 09:31:24 INFO - PROCESS | 26363 | 09:31:24 INFO - PROCESS | 26363 | [#4] prototype.html Cycles:180 Average:5021.68 Median:5758.17 stddev:1460.88 (25.4%) stddev-sans-first:1422.29 09:31:24 INFO - PROCESS | 26363 | Values: 351.3 358.6 360.4 361.7 367.0 5814.5 5842.6 5852.4 5874.6 5875.6 5606.2 5750.4 5766.0 5798.5 5827.3 4481.7 4505.4 4512.4 4519.8 4524.8 4458.4 4502.0 4502.7 4532.3 4546.6 4476.7 4483.5 4483.8 4491.8 4502.5 4322.1 4443.5 4462.5 4480.6 4486.7 4003.9 4004.4 4014.7 4015.4 4022.2 5556.3 5618.1 5621.2 5622.6 5623.2 5077.3 5100.9 5113.6 5158.7 5174.9 5968.0 5969.1 5973.9 5987.8 5995.3 4337.9 4411.7 4426.0 4426.5 4445.6 5992.4 6206.1 6211.2 6218.7 6265.3 4334.2 4338.3 4340.7 4373.5 4374.2 4385.6 4425.7 4428.7 4442.0 4469.8 4960.4 5089.6 5092.9 5104.7 5117.5 6040.7 6053.2 6054.6 6081.4 6081.7 1487.6 1495.2 1495.8 1497.7 1511.3 953.4 1005.6 1015.9 1026.9 1027.6 5600.5 5603.0 5605.3 5632.7 5651.6 5969.0 5980.7 5980.7 5993.3 6033.5 5360.5 5518.5 5589.1 5591.7 5632.4 3173.5 3180.8 3188.7 3191.6 3196.7 5884.4 6081.7 6218.2 6220.5 6275.0 5958.8 5991.1 5994.4 6012.4 6034.9 6090.2 6097.2 6123.4 6154.4 6171.2 5808.0 5815.0 5873.6 5876.5 5914.7 5791.4 5820.7 5834.6 5870.9 5881.2 6163.2 6222.9 6280.1 6340.2 6431.7 4392.9 4394.9 4399.6 4421.8 4436.7 6073.4 6102.6 6158.9 6222.9 6234.6 5956.5 6021.0 6027.7 6036.4 6056.2 5884.2 5996.6 6025.0 6052.1 6064.9 5933.3 5980.4 5991.8 5999.0 6046.0 6063.3 6070.8 6083.7 6096.7 6106.8 5780.7 5891.3 5894.6 5936.6 5966.6 09:31:24 INFO - PROCESS | 26363 | 09:31:24 INFO - PROCESS | 26363 | [#5] yui.html Cycles:180 Average:18178.82 Median:27246.73 stddev:24133.42 (88.6%) stddev-sans-first:24165.61 09:31:24 INFO - PROCESS | 26363 | Values: 743.6 776.6 799.4 839.9 857.7 14152.6 14458.3 14606.4 14690.6 15348.3 14839.4 14916.8 15037.7 15083.2 15087.0 839.2 849.7 854.4 856.5 861.2 846.0 849.0 849.8 850.1 852.6 888.8 895.5 898.2 898.7 899.2 885.5 889.2 890.9 891.6 892.6 657.6 658.9 659.4 661.3 662.6 13064.5 13065.2 13105.5 13134.8 13135.8 12453.9 12836.7 13055.5 13225.2 13257.5 11243.7 11298.3 11369.5 11376.3 11505.1 3860.6 3883.4 3948.3 3970.7 3988.6 66591.0 66931.0 67190.1 67552.0 67643.7 9854.4 10064.0 10079.7 10189.5 10321.3 19798.0 20080.6 20088.7 20121.4 20174.8 8022.2 8154.3 8205.1 8252.3 8503.0 4861.3 4882.6 4924.8 4956.0 5155.0 3479.5 3614.0 3616.3 3621.7 3637.9 631.5 637.4 654.4 655.1 655.1 686.5 778.8 784.9 793.0 816.3 9819.7 9887.6 10008.6 10231.4 10335.8 670.9 727.7 738.9 781.7 791.5 4958.0 5025.9 5072.0 5085.3 5104.1 92292.0 94469.0 95679.5 96167.5 101057.5 74887.0 76589.6 81112.6 82014.6 87629.0 47043.8 47356.8 55398.2 58620.0 64279.4 9526.5 9572.0 9621.6 9722.7 10252.6 49378.0 49537.5 49844.3 50188.5 51193.7 60927.0 62315.0 63037.0 64753.4 64905.4 13032.3 13183.5 13231.5 13247.8 13362.9 14119.4 14574.9 14678.9 14757.9 15984.8 14170.5 14361.4 14444.9 14471.9 14611.6 12619.2 13290.6 13306.9 13322.5 14867.4 13533.3 13823.4 13863.3 14049.8 14932.9 10460.2 11080.7 11144.8 11151.2 11513.7 11798.8 11858.8 12327.8 12391.2 12591.7 09:31:24 INFO - PROCESS | 26363 | -------- Summary: end -------- 09:31:24 INFO - PROCESS | 26363 | 09:31:25 INFO - TEST-INFO | 26363: exit 0 09:31:25 INFO - TEST-OK | dromaeo_css | took 1113775ms 09:31:25 INFO - TEST-START | kraken 09:31:25 INFO - operating with platform_type : linux_ 09:31:25 INFO - Initialising browser for kraken test... 09:31:25 INFO - TEST-INFO | started process 26738 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3pgwfm/profile http://localhost:36663/getInfo.html) 09:31:29 INFO - PROCESS | 26738 | __metrics Screen width/height:1600/1200 09:31:29 INFO - PROCESS | 26738 | colorDepth:24 09:31:29 INFO - PROCESS | 26738 | Browser inner width/height: 1024/697 09:31:29 INFO - PROCESS | 26738 | __metrics 09:31:30 ERROR - PROCESS | 26738 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 09:31:31 INFO - TEST-INFO | 26738: exit 0 09:31:31 INFO - Browser initialized. 09:31:31 INFO - Running cycle 1/1 for kraken test... 09:31:31 INFO - TEST-INFO | started process 26869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3pgwfm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:31:42 INFO - PROCESS | 26869 | RSS: Main: 152240128 09:31:42 INFO - PROCESS | 26869 | 09:31:45 INFO - PROCESS | 26869 | Cycle 1(1): loaded http://localhost:36663/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36663/tests/kraken/driver.html?testName=audio-beat-detection) 09:31:46 INFO - PROCESS | 26869 | RSS: Main: 157683712 09:31:46 INFO - PROCESS | 26869 | 09:31:49 INFO - PROCESS | 26869 | Cycle 1(1): loaded http://localhost:36663/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36663/tests/kraken/driver.html?testName=audio-dft) 09:31:49 INFO - PROCESS | 26869 | RSS: Main: 155222016 09:31:49 INFO - PROCESS | 26869 | 09:31:52 INFO - PROCESS | 26869 | Cycle 1(1): loaded http://localhost:36663/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36663/tests/kraken/driver.html?testName=audio-fft) 09:31:53 INFO - PROCESS | 26869 | RSS: Main: 155697152 09:31:53 INFO - PROCESS | 26869 | 09:31:55 INFO - PROCESS | 26869 | Cycle 1(1): loaded http://localhost:36663/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36663/tests/kraken/driver.html?testName=audio-oscillator) 09:31:55 INFO - PROCESS | 26869 | RSS: Main: 155553792 09:31:55 INFO - PROCESS | 26869 | 09:31:57 INFO - PROCESS | 26869 | Cycle 1(1): loaded http://localhost:36663/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36663/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:31:58 INFO - PROCESS | 26869 | RSS: Main: 155131904 09:31:58 INFO - PROCESS | 26869 | 09:32:01 INFO - PROCESS | 26869 | Cycle 1(1): loaded http://localhost:36663/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36663/tests/kraken/driver.html?testName=imaging-darkroom) 09:32:02 INFO - PROCESS | 26869 | RSS: Main: 157814784 09:32:02 INFO - PROCESS | 26869 | 09:32:05 INFO - PROCESS | 26869 | Cycle 1(1): loaded http://localhost:36663/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36663/tests/kraken/driver.html?testName=imaging-desaturate) 09:32:06 INFO - PROCESS | 26869 | RSS: Main: 157818880 09:32:06 INFO - PROCESS | 26869 | 09:32:08 INFO - PROCESS | 26869 | Cycle 1(1): loaded http://localhost:36663/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36663/tests/kraken/driver.html?testName=json-parse-financial) 09:32:09 INFO - PROCESS | 26869 | RSS: Main: 157839360 09:32:09 INFO - PROCESS | 26869 | 09:32:10 INFO - PROCESS | 26869 | Cycle 1(1): loaded http://localhost:36663/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36663/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:32:11 INFO - PROCESS | 26869 | RSS: Main: 157315072 09:32:11 INFO - PROCESS | 26869 | 09:32:13 INFO - PROCESS | 26869 | Cycle 1(1): loaded http://localhost:36663/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36663/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:32:13 INFO - PROCESS | 26869 | RSS: Main: 157335552 09:32:13 INFO - PROCESS | 26869 | 09:32:15 INFO - PROCESS | 26869 | Cycle 1(1): loaded http://localhost:36663/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36663/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:32:16 INFO - PROCESS | 26869 | RSS: Main: 158167040 09:32:16 INFO - PROCESS | 26869 | 09:32:19 INFO - PROCESS | 26869 | Cycle 1(1): loaded http://localhost:36663/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36663/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:32:19 INFO - PROCESS | 26869 | RSS: Main: 158105600 09:32:19 INFO - PROCESS | 26869 | 09:32:22 INFO - PROCESS | 26869 | Cycle 1(1): loaded http://localhost:36663/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36663/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:32:23 INFO - PROCESS | 26869 | RSS: Main: 158199808 09:32:23 INFO - PROCESS | 26869 | 09:32:24 INFO - PROCESS | 26869 | Cycle 1(1): loaded http://localhost:36663/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36663/tests/kraken/driver.html?testName=ai-astar) 09:32:25 INFO - PROCESS | 26869 | RSS: Main: 159834112 09:32:25 INFO - PROCESS | 26869 | 09:32:25 INFO - PROCESS | 26869 | __start_tp_report 09:32:25 INFO - PROCESS | 26869 | _x_x_mozilla_page_load 09:32:25 INFO - PROCESS | 26869 | _x_x_mozilla_page_load_details 09:32:25 INFO - PROCESS | 26869 | |i|pagename|runs| 09:32:25 INFO - PROCESS | 26869 | |0;ai-astar;102;114;111;112;113;111;112;117;112;112 09:32:25 INFO - PROCESS | 26869 | |1;audio-beat-detection;151;132;124;166;125;120;125;120;151;123 09:32:25 INFO - PROCESS | 26869 | |2;audio-dft;162;162;164;162;161;163;160;162;161;162 09:32:25 INFO - PROCESS | 26869 | |3;audio-fft;76;77;76;110;75;78;76;77;99;75 09:32:25 INFO - PROCESS | 26869 | |4;audio-oscillator;81;82;106;83;82;82;96;81;82;117 09:32:25 INFO - PROCESS | 26869 | |5;imaging-gaussian-blur;117;118;118;118;118;117;117;117;118;117 09:32:25 INFO - PROCESS | 26869 | |6;imaging-darkroom;147;147;147;148;148;146;149;148;147;148 09:32:25 INFO - PROCESS | 26869 | |7;imaging-desaturate;85;85;85;86;87;86;85;84;85;87 09:32:25 INFO - PROCESS | 26869 | |8;json-parse-financial;52;53;55;54;54;53;54;56;57;52 09:32:25 INFO - PROCESS | 26869 | |9;json-stringify-tinderbox;59;59;58;59;58;58;58;58;58;59 09:32:25 INFO - PROCESS | 26869 | |10;stanford-crypto-aes;76;74;75;76;84;76;80;75;75;75 09:32:25 INFO - PROCESS | 26869 | |11;stanford-crypto-ccm;134;128;130;128;130;134;127;130;174;128 09:32:25 INFO - PROCESS | 26869 | |12;stanford-crypto-pbkdf2;171;156;152;156;161;155;158;157;161;156 09:32:25 INFO - PROCESS | 26869 | |13;stanford-crypto-sha256-iterative;66;63;64;66;66;65;64;63;63;70 09:32:25 INFO - PROCESS | 26869 | __end_tp_report 09:32:25 INFO - PROCESS | 26869 | __start_cc_report 09:32:25 INFO - PROCESS | 26869 | _x_x_mozilla_cycle_collect,814 09:32:25 INFO - PROCESS | 26869 | __end_cc_report 09:32:25 INFO - PROCESS | 26869 | __startTimestamp1480613545186__endTimestamp 09:32:25 INFO - PROCESS | 26869 | 09:32:25 INFO - PROCESS | 26869 | ------- Summary: start ------- 09:32:25 INFO - PROCESS | 26869 | Number of tests: 14 09:32:25 INFO - PROCESS | 26869 | 09:32:25 INFO - PROCESS | 26869 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:3.81 (3.4%) stddev-sans-first:1.87 09:32:25 INFO - PROCESS | 26869 | Values: 102.0 114.0 111.0 112.0 113.0 111.0 112.0 117.0 112.0 112.0 09:32:25 INFO - PROCESS | 26869 | 09:32:25 INFO - PROCESS | 26869 | [#1] audio-beat-detection Cycles:10 Average:133.70 Median:128.50 stddev:16.26 (12.7%) stddev-sans-first:16.00 09:32:25 INFO - PROCESS | 26869 | Values: 151.0 132.0 124.0 166.0 125.0 120.0 125.0 120.0 151.0 123.0 09:32:25 INFO - PROCESS | 26869 | 09:32:25 INFO - PROCESS | 26869 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 09:32:25 INFO - PROCESS | 26869 | Values: 162.0 162.0 164.0 162.0 161.0 163.0 160.0 162.0 161.0 162.0 09:32:25 INFO - PROCESS | 26869 | 09:32:25 INFO - PROCESS | 26869 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.50 stddev:12.22 (16.0%) stddev-sans-first:12.78 09:32:25 INFO - PROCESS | 26869 | Values: 76.0 77.0 76.0 110.0 75.0 78.0 76.0 77.0 99.0 75.0 09:32:25 INFO - PROCESS | 26869 | 09:32:25 INFO - PROCESS | 26869 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:82.00 stddev:12.83 (15.6%) stddev-sans-first:13.26 09:32:25 INFO - PROCESS | 26869 | Values: 81.0 82.0 106.0 83.0 82.0 82.0 96.0 81.0 82.0 117.0 09:32:25 INFO - PROCESS | 26869 | 09:32:25 INFO - PROCESS | 26869 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 09:32:25 INFO - PROCESS | 26869 | Values: 117.0 118.0 118.0 118.0 118.0 117.0 117.0 117.0 118.0 117.0 09:32:25 INFO - PROCESS | 26869 | 09:32:25 INFO - PROCESS | 26869 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 09:32:25 INFO - PROCESS | 26869 | Values: 147.0 147.0 147.0 148.0 148.0 146.0 149.0 148.0 147.0 148.0 09:32:25 INFO - PROCESS | 26869 | 09:32:25 INFO - PROCESS | 26869 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.50 stddev:0.97 (1.1%) stddev-sans-first:1.01 09:32:25 INFO - PROCESS | 26869 | Values: 85.0 85.0 85.0 86.0 87.0 86.0 85.0 84.0 85.0 87.0 09:32:25 INFO - PROCESS | 26869 | 09:32:25 INFO - PROCESS | 26869 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.63 (3.0%) stddev-sans-first:1.56 09:32:25 INFO - PROCESS | 26869 | Values: 52.0 53.0 55.0 54.0 54.0 53.0 54.0 56.0 57.0 52.0 09:32:25 INFO - PROCESS | 26869 | 09:32:25 INFO - PROCESS | 26869 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 09:32:25 INFO - PROCESS | 26869 | Values: 59.0 59.0 58.0 59.0 58.0 58.0 58.0 58.0 58.0 59.0 09:32:25 INFO - PROCESS | 26869 | 09:32:25 INFO - PROCESS | 26869 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:76.00 stddev:3.06 (4.0%) stddev-sans-first:3.24 09:32:25 INFO - PROCESS | 26869 | Values: 76.0 74.0 75.0 76.0 84.0 76.0 80.0 75.0 75.0 75.0 09:32:25 INFO - PROCESS | 26869 | 09:32:25 INFO - PROCESS | 26869 | [#11] stanford-crypto-ccm Cycles:10 Average:134.30 Median:130.00 stddev:14.16 (10.9%) stddev-sans-first:15.02 09:32:25 INFO - PROCESS | 26869 | Values: 134.0 128.0 130.0 128.0 130.0 134.0 127.0 130.0 174.0 128.0 09:32:25 INFO - PROCESS | 26869 | 09:32:25 INFO - PROCESS | 26869 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.30 Median:157.50 stddev:5.21 (3.3%) stddev-sans-first:2.85 09:32:25 INFO - PROCESS | 26869 | Values: 171.0 156.0 152.0 156.0 161.0 155.0 158.0 157.0 161.0 156.0 09:32:25 INFO - PROCESS | 26869 | 09:32:25 INFO - PROCESS | 26869 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.50 stddev:2.16 (3.3%) stddev-sans-first:2.26 09:32:25 INFO - PROCESS | 26869 | Values: 66.0 63.0 64.0 66.0 66.0 65.0 64.0 63.0 63.0 70.0 09:32:25 INFO - PROCESS | 26869 | -------- Summary: end -------- 09:32:25 INFO - PROCESS | 26869 | 09:32:26 INFO - TEST-INFO | 26869: exit 0 09:32:26 INFO - TEST-OK | kraken | took 61089ms 09:32:26 INFO - SUITE-END | took 1174s 09:32:26 INFO - Completed test suite (00:19:34) 09:32:26 INFO - javascript benchmark 09:32:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7577.161933863493, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3201.2797120647856, 3222.3233121044577, 3235.3529294141176, 3235.7573182011347, 3250.6424293327746, 5646.2942132233475, 5708.8858222835515, 5723.885522289552, 5732.570057245707, 5742.741576629051, 5757.366689664133, 5800.593958422912, 5800.65196088235, 5820.825375238739, 5835.445632664901, 5224.29472021277, 5265.262863199156, 5293.68237905725, 5300.787968481275, 5318.73406329682, 5322.65402748822, 5327.653702509325, 5330.680159190441, 5340.786368545254, 5354.464553544633, 5059.468755780646, 5097.770600322994, 5279.313689220415, 5314.123169676998, 5317.9202311965355, 5202.557782588466, 5231.163013917793, 5248.606354523426, 5257.185136303879, 5295.947040529584, 5197.558207552363, 5221.6083793715625, 5290.497402746733, 5296.311479507678, 5308.283381743454, 5697.487226149667, 5737.5983681141915, 5755.338136114358, 5796.478316951495, 5831.475167234969, 6011.549133814938, 6055.0, 6065.514758819284, 6173.660448675321, 6176.289726681444, 6151.231096112986, 6172.814815555541, 6219.968900155515, 6222.0355844844125, 6229.37706229378, 5633.57748168889, 5663.688497132614, 5784.334801497797, 5794.5074668653215, 5807.332156801979, 6216.875662486725, 6243.344448832807, 6257.937420625826, 6337.96831015842, 6377.298497165308, 6084.4828189603495, 6091.42131497507, 6092.055731361646, 6101.542384321194, 6112.327643959161, 5993.820185394445, 6186.505079593621, 6198.0702894566175, 6201.596896201732, 6206.255249370014, 5945.346011938684, 6030.155778191057, 6057.969710151509, 6089.969550152221, 6130.948521380002, 6125.456844956542, 6131.233595800525, 6131.662758548323, 6168.352323006109, 6170.691465426711, 4700.083483720641, 4725.763711814396, 4731.0, 4732.503087175865, 4749.216379297446, 4061.1674606705556, 4092.3247664135083, 4093.2018256440306, 4111.075008123148, 4179.97910010448, 5801.12983052537, 5810.680412577349, 5818.389069147764, 5821.0, 5865.530757539386, 5920.970395147997, 6067.029275315928, 6076.5442591805795, 6100.0, 6131.816045518642, 5684.431556844283, 5809.88380232393, 5860.648361098262, 5860.882782344329, 5979.790707325223, 5302.8939421212135, 5342.679439233659, 5350.0, 5375.5162035416215, 5390.434004429557, 6394.872102558016, 6455.289918109004, 6457.483401327789, 6474.0612611172055, 6474.482041436674, 6047.123167140828, 6057.7879774207695, 6176.9073463897175, 6189.164462797645, 6253.812385628438, 6457.3865482779065, 6462.612243265419, 6471.902921456088, 6473.449756770728, 6489.4808415325715, 6093.786717464867, 6121.0, 6125.601835880653, 6135.171751813448, 6135.723892424762, 5987.940120598738, 6048.0625503047095, 6113.749968914014, 6161.630302181883, 6237.781677641261, 6027.457528822427, 6054.3340232575265, 6080.635161890301, 6088.726007329592, 6122.448979591858, 6055.2733671957885, 6091.7563297467605, 6096.481799047131, 6121.479674227562, 6128.295246046761, 5840.795572154954, 5873.765049397976, 5909.55678324136, 6033.849153771191, 6040.184575082308, 5978.880422391441, 6098.817035488943, 6105.17580126695, 6119.326874043941, 6143.201383820075, 5876.882462350643, 5917.615355001911, 5927.347991720993, 5941.91087133702, 5990.550708696778], "value": 5678.84158068046, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.4055814464608, 638.3999040901554, 660.369347273354, 679.3342524326164, 702.6065403374108, 41849.79075104624, 45467.772661136645, 45487.0, 45506.77246613771, 45571.08857822842, 45943.0, 46405.30392044122, 46464.76767616157, 46626.0, 46635.766821165846, 8903.73288801337, 9000.099990000981, 9057.773555661095, 9063.818723625523, 9077.95461022694, 8881.777955551099, 9035.503047332393, 9061.275097992178, 9063.637454501812, 9068.410553314014, 9014.68448604299, 9045.592948317342, 9077.909220907772, 9105.95447022764, 9110.954445227764, 8980.101989801, 8980.371374003822, 9022.233110185642, 9024.954875225614, 9025.41334813235, 8965.103489651048, 8988.056254093291, 9007.684731034447, 9028.819423611556, 9048.095190480899, 42598.36102458466, 43299.0, 43341.349879751826, 43484.0, 43516.3472547912, 3614.493970844084, 3764.9435258471144, 3823.541175058983, 3826.770393776382, 3958.4062390641634, 33433.33133337344, 33732.49401258983, 33800.492992604886, 33855.83072084648, 34028.6597134028, 4526.932096018562, 4628.930566041512, 4674.906501869978, 4686.53134686532, 4776.068666610013, 362580.0, 365920.0, 366261.1686941575, 366871.0, 368118.0, 62982.685086574274, 63238.051429228595, 63408.68295658584, 63478.36521634817, 63579.6821015892, 67270.32729672738, 67312.32687673159, 67454.0, 67679.0, 67915.0, 18058.458246252634, 18310.633787324445, 18316.358927437475, 18321.816781832276, 18329.633407331778, 14114.364853581614, 14206.715865682629, 14248.073875198286, 14303.427862885575, 14312.284385780878, 17158.477540713924, 18280.72578911291, 18553.721694174597, 18676.06619669011, 18897.716534252, 6875.5874647521305, 6898.379145876795, 6971.163460384786, 7060.752873649398, 7166.570005799668, 969.762408209993, 1072.4262519552158, 1088.6516314779194, 1107.9169062320198, 1144.2676686920377, 32078.35843283168, 33639.83180084084, 33782.49326260108, 33859.492107618404, 33913.98258052262, 1170.584442522909, 1183.5679976808576, 1190.8868657477526, 1210.939453027345, 1289.6775806048488, 17736.822631773775, 17929.7310540342, 18145.63708725818, 18315.358962436516, 18328.54178645518, 142129.0, 143135.2843235777, 143164.0, 143372.28313858365, 143824.0, 63620.36379636237, 63838.0, 64090.0, 64118.0, 64166.0, 1423.252792284059, 1426.18707336817, 1427.414759948416, 1442.6177063078292, 1451.5935538049364, 31764.205894852814, 33155.83422082874, 33276.33447331088, 33343.0, 33559.83220083884, 56147.43852561586, 56619.71690141523, 56692.433075670364, 56720.43279567151, 56860.43139568551, 441292.0, 442243.0, 446461.0, 446466.0, 447936.0, 43911.121777564906, 44359.0, 45560.0, 45856.7707161462, 46062.539374607164, 50331.496685034144, 50997.235041473665, 51271.48728512816, 51293.0, 52345.0, 42761.572384277, 43526.56473435225, 44481.0, 45175.0964980692, 45277.773611131735, 42518.5748142527, 42551.0, 43711.0, 44084.00357461994, 44442.11115777602, 38648.613513865625, 39930.80034599808, 41990.370144447246, 42916.78541607272, 44086.0, 38082.2383552333, 38627.0, 38920.6107938917, 39754.0, 40007.39988900227, 29134.56298155572, 29619.259518512208, 30269.492996157183, 30384.84807575948, 30438.0], "value": 20617.730973433503, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.5933503836317, 438.30309807406223, 441.5209497695001, 444.22482767570597, 447.219601794868, 19219.423417297487, 19657.410277691673, 19917.502062448428, 20634.17463301466, 20747.68878466824, 19537.90231048846, 20262.088206030727, 20464.795352046476, 20546.48633784156, 20701.792982070176, 5485.890282194354, 5820.912686309709, 5825.592208545403, 5826.592138550303, 5829.300483941933, 5541.944580554204, 5650.208970744099, 5653.378128405892, 5717.9714101429645, 5725.742341594639, 5637.661740295575, 5653.378128405872, 5670.234518340013, 5679.176519404684, 5687.345955215141, 5671.461211184931, 7061.611611361373, 7345.522541034816, 7378.040854688909, 7378.704851805895, 6885.793426197222, 7122.537035092702, 7181.676824542856, 7199.028131202325, 7220.277972202738, 26587.867060664765, 26904.192874213804, 27397.315067123283, 27507.31231719203, 27777.583336249972, 2557.181701855407, 2562.5387430262545, 2733.3576609496754, 2747.148384000966, 3231.806091634486, 15631.92184039084, 16409.91795041017, 16848.326066957306, 17079.743803842954, 17437.128143592898, 2067.958640827175, 2167.1873047607146, 2194.363634545996, 2197.307848027866, 2281.9543609127722, 102086.0, 106716.4664176682, 107033.0, 107164.92835071628, 107220.46389768, 17225.569360765832, 17584.384546541067, 17599.20803563843, 17677.558061048578, 18038.5490362742, 31191.376172476423, 31366.372672546877, 31390.686093138775, 31400.685993140232, 31616.525752113736, 9637.084476974676, 9877.40735555869, 9974.152197063186, 10011.949940250252, 10038.247131465168, 8268.09051004389, 8366.414350995494, 8383.371247156487, 8420.578971051424, 8507.70223042203, 8266.8346633067, 8455.323574114056, 8711.303095752452, 8754.387192896564, 8755.518446485377, 3284.3595498877967, 3421.5723034620673, 3574.2136729919375, 3603.549556305462, 3676.889693309205, 966.7389804752678, 984.8473486609587, 993.2848349188718, 1008.1884083312857, 1091.879893211746, 19400.126994285292, 19633.803661963484, 20005.899970500053, 20089.799102009085, 20123.0, 1061.6072053340158, 1084.1922767538076, 1094.6715985204407, 1096.4572536594437, 1118.6420345489366, 10596.788064238672, 10990.505427255634, 11059.72350691239, 11134.387608681438, 11147.331160130418, 163067.0, 163290.1835490815, 166406.0, 166926.0, 167438.0, 54445.72777136168, 55052.17421738677, 74108.62945685237, 81841.0, 89431.55284223537, 988.0662773678805, 991.5736233419699, 1004.4073996342194, 1015.2994433840774, 1022.5040855185377, 17303.702222333122, 17654.20556074954, 17661.205245764228, 19392.4182274532, 19541.21835126579, 44265.0887810523, 44943.77528112339, 46238.306425402974, 46377.768111159225, 47122.0, 59999.70000149971, 60073.39926600678, 60426.093608596784, 60823.0, 61751.38248617636, 6325.525585581007, 9101.317401195069, 9351.766205844908, 9414.105659962293, 9494.572744226665, 13443.46226150943, 13729.038967272196, 13747.725045499234, 13935.372908218951, 14104.365303561159, 12097.455614497192, 12124.0, 12135.393230338272, 12224.816627750413, 12270.447829847857, 11892.881071189524, 11927.10546708983, 11996.040316774812, 12028.939855300667, 12162.0, 11929.642110736691, 12242.571509997108, 12252.203606765532, 12308.507659693512, 12489.18820276679, 8910.242629376575, 9285.535723213947, 9367.5784589695, 9390.295727820578, 9603.951980240054, 11425.657230283105, 12147.0, 12179.573714919936, 12647.620571382873, 12701.93649031786], "value": 10238.888267706794, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1506.9171195584242, 1535.7082154390664, 1696.5673753192934, 1801.9819801801978, 1845.8154184581545, 7868.213178682129, 8019.23817237363, 8487.745367638972, 9126.406783559063, 9127.178553930145, 8428.53643049632, 8742.0, 8754.474731516098, 8868.778280542989, 8947.82104357914, 2423.7939775119135, 2469.9012039518398, 2473.2209354053507, 2482.577961746498, 2490.9128180513685, 2403.0507949359994, 2477.4549599088173, 2503.086373473687, 2508.4606809535944, 2517.924462266126, 2442.426029882985, 2456.054419048661, 2457.0540341968294, 2474.616434452663, 2479.47930934504, 2368.8815559222057, 2381.892814823337, 2390.354604256841, 2400.3639035655565, 2410.3853517353136, 2388.0805889732405, 2389.2115601851347, 2390.497995420964, 2414.0343862454984, 2418.9395265118337, 8745.431546949492, 8842.867356989651, 8903.955480222558, 8915.821683566357, 8936.821263574757, 5372.167314066326, 5474.0, 5531.474509921551, 5534.059209934321, 5535.972320138414, 3450.5859296884532, 3455.2053027803745, 3488.476728490721, 3525.312564050011, 3591.317649646559, 1188.6731148934025, 1222.798238290681, 1224.7366816134574, 1232.6548566401332, 1270.4918032786866, 11609.535618575332, 11723.472443739967, 11751.294922304603, 11782.646520604396, 11786.0, 4690.668512217946, 4777.163996300634, 4788.712677239377, 4856.8785780355065, 4917.483664215206, 10459.274219753655, 10476.109530689824, 10488.475576221159, 10507.894921050845, 10568.313059651098, 5486.259354987105, 5498.3127109111365, 5500.3949565547755, 5506.449355064461, 5511.862203444946, 4490.438695163105, 4606.907861842745, 4951.653384263067, 4968.205087186105, 4996.150654388763, 4083.9795801020805, 4119.92881850715, 4176.644985176234, 4200.411942328076, 4228.217779710763, 1335.6527302901316, 1375.2917247617486, 1378.951736689211, 1384.6676797568512, 1388.673661689502, 870.9869351959726, 961.0437614573405, 1005.2711783956573, 1031.4997226345217, 1049.0296475760044, 5872.469877122578, 5993.190919225936, 6029.60807547508, 6202.100695399142, 6208.689565521706, 476.9833055843029, 486.3312944701036, 486.8004118311475, 490.1373582494835, 500.81720172137636, 4102.753834769924, 4196.118815048813, 4196.265653510623, 4228.894277643022, 4324.891877703019, 10730.302530335503, 11066.833997490045, 11072.833907491395, 11162.665120046411, 11187.664370068911, 11073.335599864035, 11100.389478578756, 11102.389368584805, 11106.222564420414, 11115.83326250107, 7995.080565735015, 8313.833723325499, 8325.417220794607, 8425.36809739272, 8455.788605284917, 6119.143319935301, 6235.501159907287, 6295.118683384421, 6312.274088479883, 6332.430081292706, 10060.84908726355, 10181.440020798927, 10196.3372380795, 10252.179825613784, 10256.487175641338, 10415.68752937413, 10515.158787296845, 10545.156387489136, 10601.41692206936, 10671.786564268827, 7392.260773922565, 7629.465937384552, 7791.220877912164, 7800.492967957065, 7841.686332546634, 8590.312774978112, 8896.733098007071, 8992.820143597222, 9004.189622933967, 9004.369694121611, 7665.923340766744, 7798.727044553413, 7834.647440865288, 7948.0859701132795, 8019.6391162398995, 7809.804754881174, 7810.218978102144, 7847.764567062997, 7849.646765895434, 8053.395995300259, 7145.85708285821, 7157.355837974607, 7295.927040729737, 7368.631568421664, 7420.369268612012, 5286.180642000496, 5300.946990530046, 5385.569154467555, 5465.453454654503, 5562.415946325739, 5268.736563171903, 5293.920591191212, 5324.387695415076, 5405.405405405481, 5435.972820135874], "value": 4695.52239617603, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.2833819009221, 358.5732977756468, 360.4143267190815, 361.701596183149, 366.9541307336583, 5814.505767009804, 5842.591018628692, 5852.414758524145, 5874.6181498202695, 5875.588708790387, 5606.21512988182, 5750.367459579454, 5765.971170144144, 5798.507126894208, 5827.348556406835, 4481.663875209356, 4505.36924830524, 4512.39082723833, 4519.819207231707, 4524.8190072397065, 4458.3535387368975, 4502.0, 4502.662300327489, 4532.297493888453, 4546.613537849286, 4476.664250181233, 4483.50681425043, 4483.820647174109, 4491.820327186909, 4502.527234640348, 4322.1473827274, 4443.533428989958, 4462.464504259509, 4480.641548676098, 4486.730796152241, 4003.8798836034966, 4004.3793212051887, 4014.6788256939376, 4015.4177644241713, 4022.155347377054, 5556.305461817273, 5618.129189975561, 5621.173118736427, 5622.606417550773, 5623.212750214973, 5077.26379674945, 5100.948990510122, 5113.616478764107, 5158.74206289684, 5174.922376164361, 5967.955607768667, 5969.104634304846, 5973.940260597382, 5987.820365389045, 5995.310539287994, 4337.891552711176, 4411.691181617288, 4426.03869536766, 4426.513083560806, 4445.622122119591, 5992.352103171619, 6206.131141640174, 6211.223597050369, 6218.689065546704, 6265.342139075377, 4334.1548398062705, 4338.327559228324, 4340.717853339586, 4373.540778218305, 4374.234508960983, 4385.640451460057, 4425.668074894395, 4428.7121337112985, 4442.044960333544, 4469.754163520973, 4960.355153830051, 5089.592832573385, 5092.898142037213, 5104.668196567211, 5117.488251174927, 6040.697965101727, 6053.182820319289, 6054.606450580698, 6081.391860813972, 6081.665508397081, 1487.605784467117, 1495.2224843081538, 1495.7606782914681, 1497.670512487251, 1511.3123528794372, 953.427943234054, 1005.5625802775816, 1015.8628585140912, 1026.8767747870154, 1027.5941003303803, 5600.52395546375, 5602.971985140048, 5605.32736071674, 5632.676321064547, 5651.576131790132, 5969.0, 5980.700964951735, 5980.700964951735, 5993.250843644544, 6033.5173186145, 5360.517553420211, 5518.454832646866, 5589.149533737823, 5591.658002079553, 5632.408597097327, 3173.4767311690516, 3180.840957952093, 3188.72451019594, 3191.632962209329, 3196.7303214717344, 5884.382139875337, 6081.695915204311, 6218.22272215973, 6220.471259942956, 6275.0, 5958.761649534057, 5991.131285963511, 5994.430529099815, 6012.428819262163, 6034.922189683293, 6090.177825993523, 6097.237845269341, 6123.387201551017, 6154.446099851035, 6171.210348998829, 5807.970960145172, 5815.0, 5873.618214816023, 5876.500497457764, 5914.704264786657, 5791.420857914175, 5820.650760954356, 5834.591578589458, 5870.9412905872105, 5881.206037184926, 6163.229596300463, 6222.937770622236, 6280.089387038763, 6340.207474065742, 6431.678416079084, 4392.934105988349, 4394.890127746704, 4399.560043995575, 4421.801018954219, 4436.667249956202, 6073.423024812636, 6102.558976409472, 6158.876822463615, 6222.937770622417, 6234.625922444668, 5956.523478121827, 6020.969895150496, 6027.728752206249, 6036.426539478743, 6056.182415373868, 5884.235049443545, 5996.640201587918, 6024.969875150597, 6052.122442245938, 6064.878702426015, 5933.317668468181, 5980.43185897339, 5991.7902873399225, 5998.970005149947, 6045.969770151121, 6063.302720187058, 6070.785842831539, 6083.66539840313, 6096.725647345791, 6106.755729770759, 5780.653160810365, 5891.293044834647, 5894.55583382057, 5936.584439089395, 5966.612170208922], "value": 4553.351728878381, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.6207534157579, 776.6194564663313, 799.4284086877881, 839.9076101628822, 857.661223816592, 14152.646183845396, 14458.277086145703, 14606.415743370266, 14690.63273418165, 15348.309326080325, 14839.406423743038, 14916.776248356256, 15037.699246015072, 15083.170425626586, 15087.01934374265, 839.1524560194217, 849.6856163219618, 854.3848429131016, 856.4561503445326, 861.1603686405767, 845.995770021149, 848.9769827358019, 849.762066621347, 850.124371896944, 852.6120615120105, 888.835565420396, 895.5343221524803, 898.1871406377206, 898.734873212404, 899.2356496977582, 885.535094075609, 889.1597440418807, 890.8752774611592, 891.5854127830557, 892.6429428228696, 657.6251536624126, 658.8978708300222, 659.4032400677347, 661.2825084783016, 662.6090606542115, 13064.477420903153, 13065.216087034809, 13105.541306054338, 13134.802977955338, 13135.802962955468, 12453.93773031129, 12836.743265134739, 13055.543055992996, 13225.206487610774, 13257.46970121194, 11243.66269011931, 11298.265612735227, 11369.545218191262, 11376.317420954687, 11505.079593632572, 3860.5560360558616, 3883.436901649245, 3948.348522493785, 3970.722049456539, 3988.641022308006, 66591.0, 66931.0, 67190.11621570733, 67552.0, 67643.66178169126, 9854.359466634645, 10064.0, 10079.69760907174, 10189.490525473697, 10321.277510574188, 19798.010099494968, 20080.59838803216, 20088.69866951997, 20121.39635810928, 20174.798252017586, 8022.237887400687, 8154.347652187811, 8205.138460461685, 8252.33981281496, 8502.957485212535, 4861.319415281863, 4882.609391248691, 4924.778384972685, 4955.950440495621, 5155.0, 3479.460683594047, 3614.042278796121, 3616.349057169682, 3621.6740493355724, 3637.8544858205905, 631.4948041566728, 637.4231320654815, 654.4306453385585, 655.0796131435341, 655.1417642887832, 686.4645576450376, 778.7897267737792, 784.8548018616574, 792.9960350198212, 816.3061397811931, 9819.656312029045, 9887.604495820087, 10008.649697260707, 10231.43727095017, 10335.844962325571, 670.9463242940553, 727.6611035694348, 738.8780851159606, 781.7498400511781, 791.4934441957153, 4957.950420495821, 5025.899482010413, 5072.0, 5085.262636917626, 5104.106781313255, 92292.0, 94469.0, 95679.52160239154, 96167.51916240374, 101057.49471252596, 74887.0, 76589.61705191438, 81112.59443702744, 82014.58992705117, 87629.0, 47043.76478117587, 47356.763216183695, 55398.16902746462, 58620.0, 64279.35720642827, 9526.52367381642, 9571.952140239533, 9621.615135394506, 9722.708318750449, 10252.64115755945, 49378.0, 49537.50462495329, 49844.25233621426, 50188.49811501838, 51193.7440312796, 60927.0, 62315.0, 63037.0, 64753.35246647473, 64905.35094648993, 13032.348382580643, 13183.472661093449, 13231.470741170631, 13247.80128298057, 13362.933185334012, 14119.43522259098, 14574.85425145735, 14678.85321146775, 14757.852421475647, 15984.760228596813, 14170.504032358818, 14361.425542978164, 14444.927775361057, 14471.855281447051, 14611.634709132357, 12619.242845429304, 13290.601281961557, 13306.933465332611, 13322.467101316226, 14867.405303787727, 13533.323333833072, 13823.447062117804, 13863.306834658428, 14049.789253161007, 14932.925335373253, 10460.163186945178, 11080.667579972614, 11144.777104457704, 11151.16366272549, 11513.712157195801, 11798.764024719629, 11858.762824743284, 12327.815082773945, 12391.194572353128, 12591.685207869876], "value": 7382.919431414982, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1475.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 111.0, 112.0, 113.0, 111.0, 112.0, 117.0, 112.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 132.0, 124.0, 166.0, 125.0, 120.0, 125.0, 120.0, 151.0, 123.0], "value": 133.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 162.0, 161.0, 163.0, 160.0, 162.0, 161.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 110.0, 75.0, 78.0, 76.0, 77.0, 99.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 106.0, 83.0, 82.0, 82.0, 96.0, 81.0, 82.0, 117.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 148.0, 146.0, 149.0, 148.0, 147.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 86.0, 87.0, 86.0, 85.0, 84.0, 85.0, 87.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 55.0, 54.0, 54.0, 53.0, 54.0, 56.0, 57.0, 52.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 58.0, 59.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 76.0, 84.0, 76.0, 80.0, 75.0, 75.0, 75.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 128.0, 130.0, 128.0, 130.0, 134.0, 127.0, 130.0, 174.0, 128.0], "value": 134.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 156.0, 152.0, 156.0, 161.0, 155.0, 158.0, 157.0, 161.0, 156.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 64.0, 66.0, 66.0, 65.0, 64.0, 63.0, 63.0, 70.0], "value": 65.0, "unit": "score"}]}]} 09:32:26 INFO - Return code: 0 09:32:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:32:26 ERROR - # TBPL SUCCESS # 09:32:26 INFO - Running post-action listener: _resource_record_post_action 09:32:26 INFO - [mozharness: 2016-12-01 17:32:26.476993Z] Finished run-tests step (success) 09:32:26 INFO - Running post-run listener: _resource_record_post_run 09:32:26 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 262144; Write bytes: 355299328; Read time: 16; Write time: 298444 09:32:26 INFO - TinderboxPrint: CPU usage
13.3% 09:32:26 INFO - TinderboxPrint: I/O read bytes / time
262,144 / 16 09:32:26 INFO - TinderboxPrint: I/O write bytes / time
355,299,328 / 298,444 09:32:26 INFO - TinderboxPrint: CPU idle
8,232.3 (86.6%) 09:32:26 INFO - TinderboxPrint: CPU user
1,209.9 (12.7%) 09:32:26 INFO - TinderboxPrint: Swap in / out
0 / 0 09:32:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 109875200; Read time: 0; Write time: 122132 09:32:26 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 262144; Write bytes: 244957184; Read time: 16; Write time: 176308 09:32:27 INFO - Running post-run listener: _upload_blobber_files 09:32:27 INFO - Blob upload gear active. 09:32:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:32:27 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 09:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:32:27 INFO - (blobuploader) - INFO - Open directory for files ... 09:32:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:32:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:32:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:32:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:32:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:32:28 INFO - (blobuploader) - INFO - Done attempting. 09:32:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:32:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:32:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:32:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:32:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:32:29 INFO - (blobuploader) - INFO - Done attempting. 09:32:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:32:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:32:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:32:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:32:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:32:33 INFO - (blobuploader) - INFO - Done attempting. 09:32:33 INFO - (blobuploader) - INFO - Iteration through files over. 09:32:33 INFO - Return code: 0 09:32:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:32:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:32:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40ad7b9c4362736f8ea3656567ebb0e52f5079b4adff1de6816455412d4fb925f2a1a7dcb1de61c3de71e1bdd7a1d0694b7ce99734671e301b592c9a4be7f842", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39b50d3ec43d10f884b228e19d23c29a36fa29a991c2acee932e48439d31f096b4941dc8eb5a55c9d90b5afeac36a2b2702149bb947986c365028938a02fcfe2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f02465495f2a0920cd589639f5d0d167aa7d99372c1eb1b2caa74ef7dcc6cee909384733915af5de62246aa68cc3cd3cc8023eb648b3e64a4634e73d26a5d38a"} 09:32:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:32:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:32:33 INFO - Contents: 09:32:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40ad7b9c4362736f8ea3656567ebb0e52f5079b4adff1de6816455412d4fb925f2a1a7dcb1de61c3de71e1bdd7a1d0694b7ce99734671e301b592c9a4be7f842", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39b50d3ec43d10f884b228e19d23c29a36fa29a991c2acee932e48439d31f096b4941dc8eb5a55c9d90b5afeac36a2b2702149bb947986c365028938a02fcfe2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f02465495f2a0920cd589639f5d0d167aa7d99372c1eb1b2caa74ef7dcc6cee909384733915af5de62246aa68cc3cd3cc8023eb648b3e64a4634e73d26a5d38a"} 09:32:33 INFO - Running post-run listener: copy_logs_to_upload_dir 09:32:33 INFO - Copying logs to upload dir... 09:32:33 INFO - mkdir: /builds/slave/test/build/upload/logs 09:32:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.620017 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-12-01 09:32:33.193782) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 09:32:33.197306) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381 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-Aurora/sha512/40ad7b9c4362736f8ea3656567ebb0e52f5079b4adff1de6816455412d4fb925f2a1a7dcb1de61c3de71e1bdd7a1d0694b7ce99734671e301b592c9a4be7f842", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39b50d3ec43d10f884b228e19d23c29a36fa29a991c2acee932e48439d31f096b4941dc8eb5a55c9d90b5afeac36a2b2702149bb947986c365028938a02fcfe2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f02465495f2a0920cd589639f5d0d167aa7d99372c1eb1b2caa74ef7dcc6cee909384733915af5de62246aa68cc3cd3cc8023eb648b3e64a4634e73d26a5d38a"} build_url:https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011562 build_url: 'https://queue.taskcluster.net/v1/task/TeL4gsMeT9GH6WHGLOQfJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40ad7b9c4362736f8ea3656567ebb0e52f5079b4adff1de6816455412d4fb925f2a1a7dcb1de61c3de71e1bdd7a1d0694b7ce99734671e301b592c9a4be7f842", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39b50d3ec43d10f884b228e19d23c29a36fa29a991c2acee932e48439d31f096b4941dc8eb5a55c9d90b5afeac36a2b2702149bb947986c365028938a02fcfe2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f02465495f2a0920cd589639f5d0d167aa7d99372c1eb1b2caa74ef7dcc6cee909384733915af5de62246aa68cc3cd3cc8023eb648b3e64a4634e73d26a5d38a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 09:32:33.222593) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 09:32:33.222980) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1480612305.838118-267130381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 09:32:33.308973) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 09:32:33.309296) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 09:32:33.309605) ========= ========= Total master_lag: 0.17 =========