builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1475568838.73 results: success (0) buildid: 20161003223009 builduid: da8b200c82dc4b8c835c88128ef2bf0e revision: c8a660c5f105e60ad536ddde0c3edd637ab5b7c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 01:13:58.729985) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 01:13:58.730490) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 01:13:58.730768) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 01:13:58.745843) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 01:13:58.746266) ========= 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=af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 01:13:59-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.0M=0s 2016-10-04 01:13:59 (87.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123134 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 01:13:58.883003) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 01:13:58.883325) ========= 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=af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019633 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 01:13:58.932891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 01:13:58.933224) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c8a660c5f105e60ad536ddde0c3edd637ab5b7c1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c8a660c5f105e60ad536ddde0c3edd637ab5b7c1 --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=af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 01:13:59,491 truncating revision to first 12 chars 2016-10-04 01:13:59,491 Setting DEBUG logging. 2016-10-04 01:13:59,491 attempt 1/10 2016-10-04 01:13:59,491 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c8a660c5f105?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 01:14:00,343 unpacking tar archive at: mozilla-central-c8a660c5f105/testing/mozharness/ program finished with exit code 0 elapsedTime=1.178320 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 01:14:00.126283) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 01:14:00.126604) ========= script_repo_revision: c8a660c5f105e60ad536ddde0c3edd637ab5b7c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 01:14:00.127073) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 01:14:00.127375) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 01:14:00.138122) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-04 01:14:00.138422) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:14:00 INFO - MultiFileLogger online at 20161004 01:14:00 in /builds/slave/test 01:14:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 01:14:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:14:00 INFO - {'append_to_log': False, 01:14:00 INFO - 'base_work_dir': '/builds/slave/test', 01:14:00 INFO - 'blob_upload_branch': 'Firefox', 01:14:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:14:00 INFO - 'branch': 'Firefox', 01:14:00 INFO - 'buildbot_json_path': 'buildprops.json', 01:14:00 INFO - 'config_files': ('talos/linux_config.py',), 01:14:00 INFO - 'default_actions': ('clobber', 01:14:00 INFO - 'read-buildbot-config', 01:14:00 INFO - 'download-and-extract', 01:14:00 INFO - 'populate-webroot', 01:14:00 INFO - 'create-virtualenv', 01:14:00 INFO - 'install', 01:14:00 INFO - 'run-tests'), 01:14:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:14:00 INFO - 'download_minidump_stackwalk': True, 01:14:00 INFO - 'download_symbols': 'ondemand', 01:14:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:14:00 INFO - 'tooltool.py': '/tools/tooltool.py', 01:14:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:14:00 INFO - '/tools/misc-python/virtualenv.py')}, 01:14:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:14:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:14:00 INFO - 'installer_path': 'installer.exe', 01:14:00 INFO - 'log_level': 'info', 01:14:00 INFO - 'log_name': 'talos', 01:14:00 INFO - 'log_to_console': True, 01:14:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:14:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:14:00 INFO - 'opt_config_files': (), 01:14:00 INFO - 'pip_index': False, 01:14:00 INFO - 'sps_profile': False, 01:14:00 INFO - 'sps_profile_interval': 0, 01:14:00 INFO - 'suite': 'dromaeojs', 01:14:00 INFO - 'system_bits': '32', 01:14:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:14:00 INFO - 'title': 'talos-linux64-ix-020', 01:14:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:14:00 INFO - 'use_talos_json': True, 01:14:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:14:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:14:00 INFO - 'work_dir': 'build'} 01:14:00 INFO - [mozharness: 2016-10-04 08:14:00.787475Z] Running clobber step. 01:14:00 INFO - Running pre-action listener: _resource_record_pre_action 01:14:00 INFO - Running main action method: clobber 01:14:00 INFO - rmtree: /builds/slave/test/build 01:14:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:14:01 INFO - Running post-action listener: _resource_record_post_action 01:14:01 INFO - [mozharness: 2016-10-04 08:14:01.255484Z] Finished clobber step (success) 01:14:01 INFO - [mozharness: 2016-10-04 08:14:01.255585Z] Running read-buildbot-config step. 01:14:01 INFO - Running pre-action listener: _resource_record_pre_action 01:14:01 INFO - Running main action method: read_buildbot_config 01:14:01 INFO - Using buildbot properties: 01:14:01 INFO - { 01:14:01 INFO - "project": "", 01:14:01 INFO - "product": "firefox", 01:14:01 INFO - "script_repo_revision": "production", 01:14:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 01:14:01 INFO - "repository": "", 01:14:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 01:14:01 INFO - "buildid": "20161003223009", 01:14:01 INFO - "pgo_build": "True", 01:14:01 INFO - "basedir": "/builds/slave/test", 01:14:01 INFO - "buildnumber": 14, 01:14:01 INFO - "slavename": "talos-linux64-ix-020", 01:14:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:14:01 INFO - "platform": "ubuntu64_hw", 01:14:01 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 01:14:01 INFO - "branch": "mozilla-central", 01:14:01 INFO - "repo_path": "mozilla-central", 01:14:01 INFO - "revision": "c8a660c5f105e60ad536ddde0c3edd637ab5b7c1", 01:14:01 INFO - "stage_platform": "linux64-pgo", 01:14:01 INFO - "builduid": "da8b200c82dc4b8c835c88128ef2bf0e", 01:14:01 INFO - "slavebuilddir": "test" 01:14:01 INFO - } 01:14:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 01:14:01 INFO - Running post-action listener: _resource_record_post_action 01:14:01 INFO - [mozharness: 2016-10-04 08:14:01.258028Z] Finished read-buildbot-config step (success) 01:14:01 INFO - [mozharness: 2016-10-04 08:14:01.258115Z] Running download-and-extract step. 01:14:01 INFO - Running pre-action listener: _resource_record_pre_action 01:14:01 INFO - Running main action method: download_and_extract 01:14:01 INFO - mkdir: /builds/slave/test/build/tests 01:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:01 INFO - trying https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:14:01 INFO - Downloading https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:14:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:14:01 INFO - Downloaded 1361 bytes. 01:14:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:14:01 INFO - Using the following test package requirements: 01:14:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:14:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:14:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:14:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:01 INFO - u'jsshell-linux-x86_64.zip'], 01:14:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:14:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:14:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:14:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:14:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:14:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:14:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:14:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:14:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:14:01 INFO - Fetch https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:14:02 INFO - Http code: 200 01:14:02 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 01:14:02 INFO - x-amz-cf-id: aJ9H3VpzeRODNZy91Jd2yP34v5uguDavUjFzG25n_pK_hcNBRKllSA== 01:14:02 INFO - x-amz-version-id: KshAeQnxXbrBQ3n3tTKdx6XoePgYbQjk 01:14:02 INFO - Expected file size: 21992287 01:14:02 INFO - Obtained file size: 21992287 01:14:06 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:14:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:14:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:14:06 INFO - Fetch https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:14:07 INFO - Http code: 200 01:14:07 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 01:14:07 INFO - x-amz-cf-id: 3iM4OR0D1zr6HildjG2_XnwAG38GDnWsbprH4ks7u8sAWadXCfpEsA== 01:14:07 INFO - x-amz-version-id: KshAeQnxXbrBQ3n3tTKdx6XoePgYbQjk 01:14:07 INFO - Expected file size: 21992287 01:14:07 INFO - Obtained file size: 21992287 01:14:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 01:14:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:14:12 INFO - Fetch https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 01:14:12 INFO - Http code: 200 01:14:12 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 01:14:12 INFO - x-amz-cf-id: ieKrXC_FULCl7nm3y4u4X3iKSc8SeYNziIiqxP8ZqpU1eYOx6b-MhQ== 01:14:12 INFO - x-amz-version-id: 4ozFxgwXa54OFatvHLLqiFe.gJS.jA66 01:14:12 INFO - Expected file size: 14408522 01:14:12 INFO - Obtained file size: 14408522 01:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:13 INFO - trying https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:14:13 INFO - Downloading https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:14:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:14:14 INFO - Downloaded 59695728 bytes. 01:14:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:14:14 INFO - mkdir: /builds/slave/test/properties 01:14:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:14:14 INFO - Writing to file /builds/slave/test/properties/build_url 01:14:14 INFO - Contents: 01:14:14 INFO - build_url:https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:14:15 INFO - Running post-action listener: _resource_record_post_action 01:14:15 INFO - Running post-action listener: set_extra_try_arguments 01:14:15 INFO - [mozharness: 2016-10-04 08:14:15.376985Z] Finished download-and-extract step (success) 01:14:15 INFO - [mozharness: 2016-10-04 08:14:15.377213Z] Running populate-webroot step. 01:14:15 INFO - Running pre-action listener: _resource_record_pre_action 01:14:15 INFO - Running main action method: populate_webroot 01:14:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:14:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:14:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:14:15 INFO - '--tppagecycles', 01:14:15 INFO - '7'], 01:14:15 INFO - 'tests': ['tsvgm']}}, 01:14:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:14:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:14:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:14:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:14:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:14:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:14:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:15 INFO - 'talos_options': ['--disable-e10s'], 01:14:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:14:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:14:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:15 INFO - 'talos_options': ['--disable-e10s'], 01:14:15 INFO - 'tests': ['damp', 'tps']}, 01:14:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:15 INFO - 'tests': ['damp', 'tps']}, 01:14:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:14:15 INFO - 'tests': ['dromaeo_dom']}, 01:14:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:14:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:14:15 INFO - 'tests': ['basic_compositor_video']}, 01:14:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:14:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:14:15 INFO - 'tests': ['a11yr', 01:14:15 INFO - 'ts_paint', 01:14:15 INFO - 'tpaint', 01:14:15 INFO - 'sessionrestore', 01:14:15 INFO - 'sessionrestore_no_auto_restore', 01:14:15 INFO - 'tabpaint']}, 01:14:15 INFO - 'other-e10s': {'tests': ['a11yr', 01:14:15 INFO - 'ts_paint', 01:14:15 INFO - 'tpaint', 01:14:15 INFO - 'sessionrestore', 01:14:15 INFO - 'sessionrestore_no_auto_restore', 01:14:15 INFO - 'tabpaint']}, 01:14:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:14:15 INFO - 'ts_paint', 01:14:15 INFO - 'tpaint', 01:14:15 INFO - 'sessionrestore', 01:14:15 INFO - 'sessionrestore_no_auto_restore', 01:14:15 INFO - 'tabpaint']}, 01:14:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:14:15 INFO - 'ts_paint', 01:14:15 INFO - 'tpaint', 01:14:15 INFO - 'sessionrestore', 01:14:15 INFO - 'sessionrestore_no_auto_restore', 01:14:15 INFO - 'tabpaint']}, 01:14:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:14:15 INFO - 'tests': ['a11yr', 01:14:15 INFO - 'ts_paint', 01:14:15 INFO - 'tpaint', 01:14:15 INFO - 'sessionrestore', 01:14:15 INFO - 'sessionrestore_no_auto_restore', 01:14:15 INFO - 'tabpaint']}, 01:14:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:14:15 INFO - 'tests': ['a11yr', 01:14:15 INFO - 'ts_paint', 01:14:15 INFO - 'tpaint', 01:14:15 INFO - 'sessionrestore', 01:14:15 INFO - 'sessionrestore_no_auto_restore', 01:14:15 INFO - 'tabpaint']}, 01:14:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:14:15 INFO - 'tests': ['tsvgx', 01:14:15 INFO - 'tsvgr_opacity', 01:14:15 INFO - 'tart', 01:14:15 INFO - 'tscrollx', 01:14:15 INFO - 'cart']}, 01:14:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:14:15 INFO - 'tsvgr_opacity', 01:14:15 INFO - 'tart', 01:14:15 INFO - 'tscrollx', 01:14:15 INFO - 'cart']}, 01:14:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:15 INFO - 'talos_options': ['--disable-e10s'], 01:14:15 INFO - 'tests': ['tp5o']}, 01:14:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:15 INFO - 'tests': ['tp5o']}, 01:14:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:15 INFO - 'talos_options': ['--disable-e10s', 01:14:15 INFO - '--xperf_path', 01:14:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:14:15 INFO - 'tests': ['tp5n']}, 01:14:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:15 INFO - 'talos_options': ['--xperf_path', 01:14:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:14:15 INFO - 'tests': ['tp5n']}}, 01:14:15 INFO - 'talos.zip': {'path': '', 01:14:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:14:15 INFO - Running post-action listener: _resource_record_post_action 01:14:15 INFO - [mozharness: 2016-10-04 08:14:15.396851Z] Finished populate-webroot step (success) 01:14:15 INFO - [mozharness: 2016-10-04 08:14:15.396939Z] Running create-virtualenv step. 01:14:15 INFO - Running pre-action listener: _resource_record_pre_action 01:14:15 INFO - Running main action method: create_virtualenv 01:14:15 INFO - Creating virtualenv /builds/slave/test/build/venv 01:14:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:14:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:14:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:14:15 INFO - Using real prefix '/usr' 01:14:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:14:16 INFO - Installing distribute.............................................................................................................................................................................................done. 01:14:17 INFO - Installing pip.................done. 01:14:17 INFO - Return code: 0 01:14:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:14:18 INFO - Reading from file tmpfile_stdout 01:14:18 INFO - Output received: 01:14:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 01:14:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:14: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')]} 01:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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')]} 01:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f46ba798f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e0930>, '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 0x29e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e1cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:14: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', 'pip>=1.5'] in /builds/slave/test/build 01:14: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 pip>=1.5 01:14:18 INFO - Using env: {'DISPLAY': ':0', 01:14:18 INFO - 'HOME': '/home/cltbld', 01:14:18 INFO - 'LANG': 'en_US.UTF-8', 01:14:18 INFO - 'LANGUAGE': 'en_US:en', 01:14:18 INFO - 'LOGNAME': 'cltbld', 01:14:18 INFO - 'MAIL': '/var/mail/cltbld', 01:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:18 INFO - 'MOZ_NO_REMOTE': '1', 01:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:18 INFO - 'NO_EM_RESTART': '1', 01:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:18 INFO - 'PWD': '/builds/slave/test', 01:14:18 INFO - 'SHELL': '/bin/bash', 01:14:18 INFO - 'SHLVL': '1', 01:14:18 INFO - 'TERM': 'linux', 01:14:18 INFO - 'TMOUT': '86400', 01:14:18 INFO - 'USER': 'cltbld', 01:14:18 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382', 01:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:18 INFO - '_': '/tools/buildbot/bin/python'} 01:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:14:18 INFO - Cleaning up... 01:14:18 INFO - Return code: 0 01:14:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:14: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')]} 01:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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')]} 01:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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', '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 0x7f46ba798f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e0930>, '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 0x29e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e1cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:14: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', 'psutil>=3.1.1'] in /builds/slave/test/build 01:14: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 psutil>=3.1.1 01:14:18 INFO - Using env: {'DISPLAY': ':0', 01:14:18 INFO - 'HOME': '/home/cltbld', 01:14:18 INFO - 'LANG': 'en_US.UTF-8', 01:14:18 INFO - 'LANGUAGE': 'en_US:en', 01:14:18 INFO - 'LOGNAME': 'cltbld', 01:14:18 INFO - 'MAIL': '/var/mail/cltbld', 01:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:18 INFO - 'MOZ_NO_REMOTE': '1', 01:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:18 INFO - 'NO_EM_RESTART': '1', 01:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:18 INFO - 'PWD': '/builds/slave/test', 01:14:18 INFO - 'SHELL': '/bin/bash', 01:14:18 INFO - 'SHLVL': '1', 01:14:18 INFO - 'TERM': 'linux', 01:14:18 INFO - 'TMOUT': '86400', 01:14:18 INFO - 'USER': 'cltbld', 01:14:18 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382', 01:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:18 INFO - '_': '/tools/buildbot/bin/python'} 01:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:18 INFO - Downloading/unpacking psutil>=3.1.1 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:14:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:14:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:14:20 INFO - Installing collected packages: psutil 01:14:20 INFO - Running setup.py install for psutil 01:14:20 INFO - building 'psutil._psutil_linux' extension 01:14:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:14:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:14:20 INFO - building 'psutil._psutil_posix' extension 01:14:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:14:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:14:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:14:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:14:21 INFO - Successfully installed psutil 01:14:21 INFO - Cleaning up... 01:14:21 INFO - Return code: 0 01:14:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:21 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 0x7f46ba798f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e0930>, '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 0x29e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e1cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:14:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:14:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:14:21 INFO - Using env: {'DISPLAY': ':0', 01:14:21 INFO - 'HOME': '/home/cltbld', 01:14:21 INFO - 'LANG': 'en_US.UTF-8', 01:14:21 INFO - 'LANGUAGE': 'en_US:en', 01:14:21 INFO - 'LOGNAME': 'cltbld', 01:14:21 INFO - 'MAIL': '/var/mail/cltbld', 01:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:21 INFO - 'MOZ_NO_REMOTE': '1', 01:14:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:21 INFO - 'NO_EM_RESTART': '1', 01:14:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:21 INFO - 'PWD': '/builds/slave/test', 01:14:21 INFO - 'SHELL': '/bin/bash', 01:14:21 INFO - 'SHLVL': '1', 01:14:21 INFO - 'TERM': 'linux', 01:14:21 INFO - 'TMOUT': '86400', 01:14:21 INFO - 'USER': 'cltbld', 01:14:21 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382', 01:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:21 INFO - '_': '/tools/buildbot/bin/python'} 01:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:14:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:14:23 INFO - Installing collected packages: mozsystemmonitor 01:14:23 INFO - Running setup.py install for mozsystemmonitor 01:14:23 INFO - Successfully installed mozsystemmonitor 01:14:23 INFO - Cleaning up... 01:14:23 INFO - Return code: 0 01:14:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:14: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')]} 01:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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')]} 01:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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', '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 0x7f46ba798f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e0930>, '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 0x29e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e1cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:14: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:14: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 jsonschema==2.5.1 01:14:23 INFO - Using env: {'DISPLAY': ':0', 01:14:23 INFO - 'HOME': '/home/cltbld', 01:14:23 INFO - 'LANG': 'en_US.UTF-8', 01:14:23 INFO - 'LANGUAGE': 'en_US:en', 01:14:23 INFO - 'LOGNAME': 'cltbld', 01:14:23 INFO - 'MAIL': '/var/mail/cltbld', 01:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:23 INFO - 'MOZ_NO_REMOTE': '1', 01:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:23 INFO - 'NO_EM_RESTART': '1', 01:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:23 INFO - 'PWD': '/builds/slave/test', 01:14:23 INFO - 'SHELL': '/bin/bash', 01:14:23 INFO - 'SHLVL': '1', 01:14:23 INFO - 'TERM': 'linux', 01:14:23 INFO - 'TMOUT': '86400', 01:14:23 INFO - 'USER': 'cltbld', 01:14:23 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382', 01:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:23 INFO - '_': '/tools/buildbot/bin/python'} 01:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:23 INFO - Downloading/unpacking jsonschema==2.5.1 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:14:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14:25 INFO - Downloading functools32-3.2.3-2.tar.gz 01:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:14:25 INFO - warning: no files found matching '*.txt' 01:14:25 INFO - no previously-included directories found matching 'build' 01:14:25 INFO - no previously-included directories found matching 'dist' 01:14:25 INFO - no previously-included directories found matching '.git*' 01:14:25 INFO - Installing collected packages: jsonschema, functools32 01:14:25 INFO - Running setup.py install for functools32 01:14:26 INFO - warning: no files found matching '*.txt' 01:14:26 INFO - no previously-included directories found matching 'build' 01:14:26 INFO - no previously-included directories found matching 'dist' 01:14:26 INFO - no previously-included directories found matching '.git*' 01:14:26 INFO - Successfully installed jsonschema functools32 01:14:26 INFO - Cleaning up... 01:14:26 INFO - Return code: 0 01:14:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:26 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 0x7f46ba798f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e0930>, '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 0x29e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e1cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:14:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:14:26 INFO - Using env: {'DISPLAY': ':0', 01:14:26 INFO - 'HOME': '/home/cltbld', 01:14:26 INFO - 'LANG': 'en_US.UTF-8', 01:14:26 INFO - 'LANGUAGE': 'en_US:en', 01:14:26 INFO - 'LOGNAME': 'cltbld', 01:14:26 INFO - 'MAIL': '/var/mail/cltbld', 01:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:26 INFO - 'MOZ_NO_REMOTE': '1', 01:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:26 INFO - 'NO_EM_RESTART': '1', 01:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:26 INFO - 'PWD': '/builds/slave/test', 01:14:26 INFO - 'SHELL': '/bin/bash', 01:14:26 INFO - 'SHLVL': '1', 01:14:26 INFO - 'TERM': 'linux', 01:14:26 INFO - 'TMOUT': '86400', 01:14:26 INFO - 'USER': 'cltbld', 01:14:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382', 01:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:26 INFO - '_': '/tools/buildbot/bin/python'} 01:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:14:26 INFO - Cleaning up... 01:14:26 INFO - Return code: 0 01:14:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:26 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 0x7f46ba798f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e0930>, '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 0x29e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e1cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:14:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:14:26 INFO - Using env: {'DISPLAY': ':0', 01:14:26 INFO - 'HOME': '/home/cltbld', 01:14:26 INFO - 'LANG': 'en_US.UTF-8', 01:14:26 INFO - 'LANGUAGE': 'en_US:en', 01:14:26 INFO - 'LOGNAME': 'cltbld', 01:14:26 INFO - 'MAIL': '/var/mail/cltbld', 01:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:26 INFO - 'MOZ_NO_REMOTE': '1', 01:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:26 INFO - 'NO_EM_RESTART': '1', 01:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:26 INFO - 'PWD': '/builds/slave/test', 01:14:26 INFO - 'SHELL': '/bin/bash', 01:14:26 INFO - 'SHLVL': '1', 01:14:26 INFO - 'TERM': 'linux', 01:14:26 INFO - 'TMOUT': '86400', 01:14:26 INFO - 'USER': 'cltbld', 01:14:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382', 01:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:26 INFO - '_': '/tools/buildbot/bin/python'} 01:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:26 INFO - Downloading/unpacking blobuploader==1.2.4 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14:28 INFO - Downloading blobuploader-1.2.4.tar.gz 01:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:14:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:14:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:29 INFO - Downloading docopt-0.6.1.tar.gz 01:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:14:29 INFO - Installing collected packages: blobuploader, requests, docopt 01:14:29 INFO - Running setup.py install for blobuploader 01:14:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:14:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:14:29 INFO - Running setup.py install for requests 01:14:29 INFO - Running setup.py install for docopt 01:14:29 INFO - Successfully installed blobuploader requests docopt 01:14:29 INFO - Cleaning up... 01:14:29 INFO - Return code: 0 01:14:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:29 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 0x7f46ba798f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e0930>, '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 0x29e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e1cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:14:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:14:29 INFO - Using env: {'DISPLAY': ':0', 01:14:29 INFO - 'HOME': '/home/cltbld', 01:14:29 INFO - 'LANG': 'en_US.UTF-8', 01:14:29 INFO - 'LANGUAGE': 'en_US:en', 01:14:29 INFO - 'LOGNAME': 'cltbld', 01:14:29 INFO - 'MAIL': '/var/mail/cltbld', 01:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:29 INFO - 'MOZ_NO_REMOTE': '1', 01:14:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:29 INFO - 'NO_EM_RESTART': '1', 01:14:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:29 INFO - 'PWD': '/builds/slave/test', 01:14:29 INFO - 'SHELL': '/bin/bash', 01:14:29 INFO - 'SHLVL': '1', 01:14:29 INFO - 'TERM': 'linux', 01:14:29 INFO - 'TMOUT': '86400', 01:14:29 INFO - 'USER': 'cltbld', 01:14:29 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382', 01:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:29 INFO - '_': '/tools/buildbot/bin/python'} 01:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:14:30 INFO - Running setup.py (path:/tmp/pip-4rjzFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:14:30 INFO - Running setup.py (path:/tmp/pip-ctSjZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:14:30 INFO - Running setup.py (path:/tmp/pip-VelnOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:14:30 INFO - Running setup.py (path:/tmp/pip-AhpfFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:14:30 INFO - Running setup.py (path:/tmp/pip-duT1v3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:14:30 INFO - Running setup.py (path:/tmp/pip-gBub5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:14:30 INFO - Running setup.py (path:/tmp/pip-k5kEDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:14:30 INFO - Running setup.py (path:/tmp/pip-LxqAKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:14:30 INFO - Running setup.py (path:/tmp/pip-PXCqol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:14:30 INFO - Running setup.py (path:/tmp/pip-NLzzWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:14:30 INFO - Running setup.py (path:/tmp/pip-KjZiqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:14:30 INFO - Running setup.py (path:/tmp/pip-atTtht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:14:30 INFO - Running setup.py (path:/tmp/pip-kxjxir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:14:30 INFO - Running setup.py (path:/tmp/pip-xQUo1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:31 INFO - Running setup.py (path:/tmp/pip-0pgeMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:14:31 INFO - Running setup.py (path:/tmp/pip-JJuMXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:14:31 INFO - Running setup.py (path:/tmp/pip-Pa0XUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:14:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:14:31 INFO - Running setup.py install for manifestparser 01:14:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:14:31 INFO - Running setup.py install for mozcrash 01:14:31 INFO - Running setup.py install for mozdebug 01:14:31 INFO - Running setup.py install for mozdevice 01:14:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:14:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:14:31 INFO - Running setup.py install for mozfile 01:14:31 INFO - Running setup.py install for mozhttpd 01:14:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:14:31 INFO - Running setup.py install for mozinfo 01:14:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:14:31 INFO - Running setup.py install for mozInstall 01:14:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:14:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:14:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:14:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:14:32 INFO - Running setup.py install for mozleak 01:14:32 INFO - Running setup.py install for mozlog 01:14:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:14:32 INFO - Running setup.py install for moznetwork 01:14:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:14:32 INFO - Running setup.py install for mozprocess 01:14:32 INFO - Running setup.py install for mozprofile 01:14:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:14:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:14:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:14:32 INFO - Running setup.py install for mozrunner 01:14:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:14:32 INFO - Running setup.py install for mozscreenshot 01:14:32 INFO - Running setup.py install for moztest 01:14:32 INFO - Running setup.py install for mozversion 01:14:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:14:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:14:33 INFO - Cleaning up... 01:14:33 INFO - Return code: 0 01:14:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:33 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 0x7f46ba798f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e0930>, '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 0x29e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e1cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:14:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:14:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:14:33 INFO - Using env: {'DISPLAY': ':0', 01:14:33 INFO - 'HOME': '/home/cltbld', 01:14:33 INFO - 'LANG': 'en_US.UTF-8', 01:14:33 INFO - 'LANGUAGE': 'en_US:en', 01:14:33 INFO - 'LOGNAME': 'cltbld', 01:14:33 INFO - 'MAIL': '/var/mail/cltbld', 01:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:33 INFO - 'MOZ_NO_REMOTE': '1', 01:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:33 INFO - 'NO_EM_RESTART': '1', 01:14:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:33 INFO - 'PWD': '/builds/slave/test', 01:14:33 INFO - 'SHELL': '/bin/bash', 01:14:33 INFO - 'SHLVL': '1', 01:14:33 INFO - 'TERM': 'linux', 01:14:33 INFO - 'TMOUT': '86400', 01:14:33 INFO - 'USER': 'cltbld', 01:14:33 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382', 01:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:33 INFO - '_': '/tools/buildbot/bin/python'} 01:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:14:33 INFO - Running setup.py (path:/tmp/pip-MJGItI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:14:33 INFO - Running setup.py (path:/tmp/pip-1BYNP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:14:33 INFO - Running setup.py (path:/tmp/pip-FkFQty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:14:33 INFO - Running setup.py (path:/tmp/pip-pBIH3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:14:33 INFO - Running setup.py (path:/tmp/pip-Re4Cnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:14:33 INFO - Running setup.py (path:/tmp/pip-FSm52O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:14:33 INFO - Running setup.py (path:/tmp/pip-VsJ4Fi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:14:33 INFO - Running setup.py (path:/tmp/pip-b_JU01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:14:33 INFO - Running setup.py (path:/tmp/pip-pqoENL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:14:33 INFO - Running setup.py (path:/tmp/pip-TLV2RG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:14:34 INFO - Running setup.py (path:/tmp/pip-fQEFdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:14:34 INFO - Running setup.py (path:/tmp/pip-JviOZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:14:34 INFO - Running setup.py (path:/tmp/pip-F4ih8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:14:34 INFO - Running setup.py (path:/tmp/pip-PrOA1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:34 INFO - Running setup.py (path:/tmp/pip-yn7cux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:14:34 INFO - Running setup.py (path:/tmp/pip-luGnwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:14:34 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)) 01:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:14:34 INFO - Running setup.py (path:/tmp/pip-fgiuw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:14:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:36 INFO - Downloading blessings-1.6.tar.gz 01:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:14:36 INFO - Installing collected packages: blessings 01:14:36 INFO - Running setup.py install for blessings 01:14:36 INFO - Successfully installed blessings 01:14:36 INFO - Cleaning up... 01:14:36 INFO - Return code: 0 01:14:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:14:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:14:36 INFO - Reading from file tmpfile_stdout 01:14:36 INFO - Current package versions: 01:14:36 INFO - argparse == 1.2.1 01:14:36 INFO - blessings == 1.6 01:14:36 INFO - blobuploader == 1.2.4 01:14:36 INFO - docopt == 0.6.1 01:14:36 INFO - functools32 == 3.2.3-2 01:14:36 INFO - jsonschema == 2.5.1 01:14:36 INFO - manifestparser == 1.1 01:14:36 INFO - mozInstall == 1.12 01:14:36 INFO - mozcrash == 0.17 01:14:36 INFO - mozdebug == 0.1 01:14:36 INFO - mozdevice == 0.48 01:14:36 INFO - mozfile == 1.2 01:14:36 INFO - mozhttpd == 0.7 01:14:36 INFO - mozinfo == 0.9 01:14:36 INFO - mozleak == 0.1 01:14:36 INFO - mozlog == 3.4 01:14:36 INFO - moznetwork == 0.27 01:14:36 INFO - mozprocess == 0.23 01:14:36 INFO - mozprofile == 0.28 01:14:36 INFO - mozrunner == 6.12 01:14:36 INFO - mozscreenshot == 0.1 01:14:36 INFO - mozsystemmonitor == 0.3 01:14:36 INFO - moztest == 0.7 01:14:36 INFO - mozversion == 1.4 01:14:36 INFO - psutil == 3.1.1 01:14:36 INFO - requests == 1.2.3 01:14:36 INFO - wsgiref == 0.1.2 01:14:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:36 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 0x7f46ba798f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e0930>, '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 0x29e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e1cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:14:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:14:36 INFO - Using env: {'DISPLAY': ':0', 01:14:36 INFO - 'HOME': '/home/cltbld', 01:14:36 INFO - 'LANG': 'en_US.UTF-8', 01:14:36 INFO - 'LANGUAGE': 'en_US:en', 01:14:36 INFO - 'LOGNAME': 'cltbld', 01:14:36 INFO - 'MAIL': '/var/mail/cltbld', 01:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:36 INFO - 'MOZ_NO_REMOTE': '1', 01:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:36 INFO - 'NO_EM_RESTART': '1', 01:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:36 INFO - 'PWD': '/builds/slave/test', 01:14:36 INFO - 'SHELL': '/bin/bash', 01:14:36 INFO - 'SHLVL': '1', 01:14:36 INFO - 'TERM': 'linux', 01:14:36 INFO - 'TMOUT': '86400', 01:14:36 INFO - 'USER': 'cltbld', 01:14:36 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382', 01:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:36 INFO - '_': '/tools/buildbot/bin/python'} 01:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:14:37 INFO - Cleaning up... 01:14:37 INFO - Return code: 0 01:14:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f46ba798f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e0930>, '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 0x29e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e1cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:14:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:14:37 INFO - Using env: {'DISPLAY': ':0', 01:14:37 INFO - 'HOME': '/home/cltbld', 01:14:37 INFO - 'LANG': 'en_US.UTF-8', 01:14:37 INFO - 'LANGUAGE': 'en_US:en', 01:14:37 INFO - 'LOGNAME': 'cltbld', 01:14:37 INFO - 'MAIL': '/var/mail/cltbld', 01:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:37 INFO - 'MOZ_NO_REMOTE': '1', 01:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:37 INFO - 'NO_EM_RESTART': '1', 01:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:37 INFO - 'PWD': '/builds/slave/test', 01:14:37 INFO - 'SHELL': '/bin/bash', 01:14:37 INFO - 'SHLVL': '1', 01:14:37 INFO - 'TERM': 'linux', 01:14:37 INFO - 'TMOUT': '86400', 01:14:37 INFO - 'USER': 'cltbld', 01:14:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382', 01:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:37 INFO - '_': '/tools/buildbot/bin/python'} 01:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:14:37 INFO - Cleaning up... 01:14:37 INFO - Return code: 0 01:14:37 INFO - Running post-action listener: _resource_record_post_action 01:14:37 INFO - Running post-action listener: _start_resource_monitoring 01:14:37 INFO - Starting resource monitoring. 01:14:37 INFO - [mozharness: 2016-10-04 08:14:37.386975Z] Finished create-virtualenv step (success) 01:14:37 INFO - [mozharness: 2016-10-04 08:14:37.387535Z] Running install step. 01:14:37 INFO - Running pre-action listener: _resource_record_pre_action 01:14:37 INFO - Running main action method: install 01:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:14:37 INFO - Reading from file tmpfile_stdout 01:14:37 INFO - Detecting whether we're running mozinstall >=1.0... 01:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:14:37 INFO - Reading from file tmpfile_stdout 01:14:37 INFO - Output received: 01:14:37 INFO - Usage: mozinstall [options] installer 01:14:37 INFO - Options: 01:14:37 INFO - -h, --help show this help message and exit 01:14:37 INFO - -d DEST, --destination=DEST 01:14:37 INFO - Directory to install application into. [default: 01:14:37 INFO - "/builds/slave/test"] 01:14:37 INFO - --app=APP Application being installed. [default: firefox] 01:14:37 INFO - mkdir: /builds/slave/test/build/application 01:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:14:54 INFO - Reading from file tmpfile_stdout 01:14:54 INFO - Output received: 01:14:54 INFO - /builds/slave/test/build/application/firefox/firefox 01:14:54 INFO - Running post-action listener: _resource_record_post_action 01:14:54 INFO - [mozharness: 2016-10-04 08:14:54.696814Z] Finished install step (success) 01:14:54 INFO - [mozharness: 2016-10-04 08:14:54.697058Z] Running run-tests step. 01:14:54 INFO - Running pre-action listener: _resource_record_pre_action 01:14:54 INFO - Running main action method: run_tests 01:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:14:54 INFO - Python 2.7.3 01:14:54 INFO - Return code: 0 01:14:54 INFO - grabbing minidump binary from tooltool 01:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:54 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 0x29e0930>, '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 0x29e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e1cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:14:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:14:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:14:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:14:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:14:54 INFO - Return code: 0 01:14:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:14:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:14:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:14:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:14:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:14:54 INFO - Using env: {'DISPLAY': ':0', 01:14:54 INFO - 'HOME': '/home/cltbld', 01:14:54 INFO - 'LANG': 'en_US.UTF-8', 01:14:54 INFO - 'LANGUAGE': 'en_US:en', 01:14:54 INFO - 'LOGNAME': 'cltbld', 01:14:54 INFO - 'MAIL': '/var/mail/cltbld', 01:14:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:14:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:54 INFO - 'MOZ_NO_REMOTE': '1', 01:14:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:54 INFO - 'NO_EM_RESTART': '1', 01:14:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:54 INFO - 'PWD': '/builds/slave/test', 01:14:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:14:54 INFO - 'SHELL': '/bin/bash', 01:14:54 INFO - 'SHLVL': '1', 01:14:54 INFO - 'TERM': 'linux', 01:14:54 INFO - 'TMOUT': '86400', 01:14:54 INFO - 'USER': 'cltbld', 01:14:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382', 01:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:54 INFO - '_': '/tools/buildbot/bin/python'} 01:14:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:14:54 INFO - mozversion application_buildid: 20161003223009 01:14:54 INFO - mozversion application_changeset: c8a660c5f105e60ad536ddde0c3edd637ab5b7c1 01:14:54 INFO - mozversion application_display_name: Nightly 01:14:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:14:54 INFO - mozversion application_name: Firefox 01:14:54 INFO - mozversion application_remotingname: firefox 01:14:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:14:54 INFO - mozversion application_vendor: Mozilla 01:14:54 INFO - mozversion application_version: 52.0a1 01:14:54 INFO - mozversion platform_buildid: 20161003223009 01:14:54 INFO - mozversion platform_changeset: c8a660c5f105e60ad536ddde0c3edd637ab5b7c1 01:14:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:14:54 INFO - mozversion platform_version: 52.0a1 01:14:54 INFO - using testdate: 1475568894 01:14:54 INFO - actual date: 1475568894 01:14:54 INFO - starting webserver on 'localhost:58400' 01:14:54 INFO - SUITE-START | Running 2 tests 01:14:54 INFO - TEST-START | dromaeo_css 01:14:54 INFO - operating with platform_type : linux_ 01:14:54 INFO - Initialising browser for dromaeo_css test... 01:14:54 INFO - TEST-INFO | started process 7185 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuo5bMD/profile http://localhost:58400/getInfo.html) 01:14:59 INFO - PROCESS | 7185 | __metrics Screen width/height:1600/1200 01:14:59 INFO - PROCESS | 7185 | colorDepth:24 01:14:59 INFO - PROCESS | 7185 | Browser inner width/height: 1024/697 01:14:59 INFO - PROCESS | 7185 | __metrics 01:15:00 INFO - PROCESS | 7185 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:15:00 INFO - PROCESS | 7185 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:15:00 INFO - PROCESS | 7185 | console.error: PushService: 01:15:00 INFO - PROCESS | 7185 | stateChangeProcessEnqueue: Error transitioning state 01:15:00 INFO - PROCESS | 7185 | UnknownError 01:15:01 INFO - TEST-INFO | 7185: exit 0 01:15:01 INFO - Browser initialized. 01:15:01 INFO - Running cycle 1/1 for dromaeo_css test... 01:15:01 INFO - TEST-INFO | started process 7268 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuo5bMD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:15:13 INFO - PROCESS | 7268 | RSS: Main: 173940736 01:15:13 INFO - PROCESS | 7268 | 01:16:04 INFO - PROCESS | 7268 | 1475568964839 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] 01:18:15 INFO - PROCESS | 7268 | Cycle 1(1): loaded http://localhost:58400/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58400/tests/dromaeo/cssquery-ext.html) 01:18:16 INFO - PROCESS | 7268 | RSS: Main: 305754112 01:18:16 INFO - PROCESS | 7268 | 01:21:19 INFO - PROCESS | 7268 | Cycle 1(1): loaded http://localhost:58400/tests/dromaeo/cssquery-ext.html (next: http://localhost:58400/tests/dromaeo/cssquery-jquery.html) 01:21:19 INFO - PROCESS | 7268 | RSS: Main: 272134144 01:21:19 INFO - PROCESS | 7268 | 01:24:21 INFO - PROCESS | 7268 | Cycle 1(1): loaded http://localhost:58400/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58400/tests/dromaeo/cssquery-mootools.html) 01:24:22 INFO - PROCESS | 7268 | RSS: Main: 216616960 01:24:22 INFO - PROCESS | 7268 | 01:27:24 INFO - PROCESS | 7268 | Cycle 1(1): loaded http://localhost:58400/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58400/tests/dromaeo/cssquery-prototype.html) 01:27:25 INFO - PROCESS | 7268 | RSS: Main: 218324992 01:27:25 INFO - PROCESS | 7268 | 01:30:27 INFO - PROCESS | 7268 | Cycle 1(1): loaded http://localhost:58400/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58400/tests/dromaeo/cssquery-yui.html) 01:30:28 INFO - PROCESS | 7268 | RSS: Main: 221503488 01:30:28 INFO - PROCESS | 7268 | 01:33:31 INFO - PROCESS | 7268 | Cycle 1(1): loaded http://localhost:58400/tests/dromaeo/cssquery-yui.html (next: http://localhost:58400/tests/dromaeo/cssquery-dojo.html) 01:33:31 INFO - PROCESS | 7268 | RSS: Main: 311230464 01:33:31 INFO - PROCESS | 7268 | 01:33:31 INFO - PROCESS | 7268 | __start_tp_report 01:33:31 INFO - PROCESS | 7268 | _x_x_mozilla_page_load 01:33:31 INFO - PROCESS | 7268 | _x_x_mozilla_page_load_details 01:33:31 INFO - PROCESS | 7268 | |i|pagename|runs| 01:33:31 INFO - PROCESS | 7268 | |0;dojo.html;3004.2489377655584;3033.0597514770416;3033.590465287187;3065.8620362083702;3084.7994880332776;5198.610104242178;5200.661956972799;5273.367195936493;5301.469853014702;5308.495692909172;5294.92057619136;5295.099833028385;5295.205719142131;5323.733813309329;5327.067763141445;4796.040791841637;4803.855884323476;4906.705597664134;4913.434954980169;4925.113479573675;4821.108095002436;4832.130216561018;4838.661293709441;4876.829310974116;4877.70733755974;4918.950810491903;4972.279019542164;4984.75076246188;4986.700797952117;5024.095662780698;4777.06847164803;4817.036592681443;4879.316895634614;4894.363732714724;4949.50504949504;4861.197902346109;4865.148598995197;4865.756712164378;4866.440359358684;4870.415550133971;5264.473552644743;5316.867078323035;5317.494837990384;5322.2282768998275;5343.412224655285;5554.638948468337;5602.299712535933;5676.403977582336;5721.141828725683;5726.141078838166;5614.887702245973;5622.49397554218;5667.348254950651;5696.202531645573;5717.313922329306;5168.379794424618;5267.578593712494;5281.313429254211;5302.2046692996355;5362.839114826562;5728.455796699307;5737.913931291034;5779.942200577941;5799.5650326225705;5814.476697097281;5547.972260138674;5572.359178694502;5584.46947539983;5584.692841893735;5586.441355864381;5514.558835293167;5632.887342253132;5640.041192997201;5640.802571910045;5644.8024319148635;5538.889222215533;5588.385277619459;5632.3804381518;5635.8591035224445;5742.885142297131;5617.41017193197;5651.378348381675;5662.66024038559;5663.858403539944;5665.575081868877;4269.338252570795;4273.807678654468;4275.657947364266;4281.593248641374;4327.632151267115;3786.8295926683363;3792.60177681345;3808.352580061396;3812.694984401241;3820.8662696806036;5357.517823395913;5360.973195133999;5375.9462405376225;5376.327959005124;5428.457154284619;5653.293338332708;5699.886002279931;5707.743151558107;5714.714264286769;5715.857103572361;5226.529612334908;5271.551918087006;5279.128943724242;5341.038613049688;5432.891342173134;4764.309175169581;4805.663603547788;4809.350737650442;4821.083994041121;4832.685875418087;5802.767889284466;5935.347111817697;5960.837636660896;5962.552808539377;5965.850853728692;5718.399568045295;5722.656640601577;5727.914081288867;5729.684867332337;5735.799247026334;5832.387599302012;5839.532837372915;5882.852928676817;5892.469677729025;5896.056630939201;5452.400235973961;5488.560915126701;5502.367227768857;5556.638818476786;5560.805371812129;5684.857878553069;5685.602007859576;5687.033204355187;5691;5742.856428589319;5495.890082198413;5521.420250873601;5526.696031718294;5532.114861622121;5536.695481748542;5387.838364849061;5444.047291724011;5507.834764957058;5514.338279406497;5585.832425027255;5532.585056120726;5547.084731019337;5564.860878478071;5602.1036634138345;5621.213030175697;5635.830925072254;5641.9435805641415;5644.887102258014;5645.520130788929;5650.23721797552;5323.547498462674;5331.5201631853315;5390.380106287827;5513.9448605513435;5521.641093328921 01:33:31 INFO - PROCESS | 7268 | |1;ext.html;555.591640144494;602.0517684646682;614.1494030767386;614.7141579165688;617.1575799034317;34081.97754067376;34692.65307346926;34801.82599087004;34804;41375;43541.78229108858;43730.7813460933;43786;43898.561014389845;43899.56100438994;8788.69239576615;8950.41822281553;8953.686620968267;8956.8656470153;8959;7938.761837144895;8238.217369349932;8834.293256539462;8841.248493877996;8938.731838044836;10425.218108641882;10678.51946662402;10678.572857085746;11018.944905275463;11022.724431889186;10213.33613315132;10242.129418999393;10268.486575671186;10292;10365;10590.09984151348;10649.627263045757;10652.467376631137;10654.09440197584;10659.733506662318;41645.79177104125;41765.1646967062;41780.1643967122;41910.79044604788;41927.16145677069;2987.835669038202;3022.425739109562;3034.408290383376;3068.7391571716207;3071.5853359796365;31027.53458698121;31030.0690979271;31295;31550.684493155233;31820.36359272825;3981.7411868228473;4011.5587285398583;4026.1142548639255;4173.791310434466;4180.372944058385;319504;321756;321775;321850;322701;55598;55885;55896.44103558994;55931.720341398846;55952;34795;36147.27705445876;58740.412595874346;58770.41229587735;58897.87714860004;15604.29780659873;15724.921375393049;15765.132917689638;15772.842271577367;15783.053016819027;11811.232269902428;11891.227070240408;11900.523979040741;11901.464434100486;11902.821457678141;15803;16392.344306227857;17869;18411.94937113833;18572.88562686216;6965.442764578822;7017.298270172942;7172.820679483055;7191.7842464726145;7248.710051597877;790.5493868495017;872.956352182401;876.8991565969867;918.3525614441802;955.3538586951086;25816.612750808752;27003.324916877235;27238.45523089527;30538.69461305403;32105.197370065936;1053.394298278493;1085.6146068145852;1094.1902991786021;1161.3380373187201;1161.6805378520974;15796.684066318609;16440;16441.753373699405;16525.83474165243;16613.833861661227;500426;502967;506706;508286;508314;55070.173947390824;55667.44332556704;55699.72150139223;55713;55742.72128639331;1309.4107651556646;1327.5685402244117;1341.8322709661293;1348.5954213736036;1358.110437663332;27750.72249277562;29659.555106673848;29742.405151897274;29852.402951940407;30141.849290753406;49115.50884491109;50116.498835012644;50226.24660630167;50257;50284.49715502798;483278;484207;484661;484903;487158.334708257;23726.288211353687;24401.145959891317;24634.507309853343;24836.37909052288;25812.09657661973;40088.7995560032;44054.33918491161;44491.555084448744;44989.550104498536;45733.314000289356;37761.811190944965;38854.222915540966;39163.41254881122;39267.80366098151;40534;37050.62949370472;37969.43045854259;38078.80960595179;38986.4152037714;39627.405588915615;38215.42676859905;38775.21433749026;39923.201535969696;40360.59639403568;40429.39355909605;30194.84902575473;34240.315193696486;34511.82744086264;35538;35617.1095722609;23187.101612298462;23744.287671369886;23952.52094958126;24051.75948240565;24160.87919560391 01:33:31 INFO - PROCESS | 7268 | |2;jquery.html;397.1936967955052;407.18359688823904;407.338075627106;414.1571901181097;429.74215470717576;13090.869091309083;17523.561910952216;18855;19497.220111195555;19510.707339389886;13869.4452221911;13940;16436.096014719187;16623.50129496114;17385.82614173858;5486.3690675572325;5520.889582208353;5775.3358363788075;5798.130280457923;5907.970460147693;5749.770009199627;5805.912911306334;5810.56420768442;5818.883622327551;5823.446772556622;6399.008153736155;6447.065175549543;6449.48404127671;6452.354764523557;6457.806265812033;5803.883922321572;5844.970775146139;6126.387361263883;6444;6458.515611329169;5674.319081710221;5675.262215911946;5677.772889084432;5678.630888992202;5679.2333035040565;13148.86851131486;20406.387808365773;21250.468738281514;21317.467063323387;22331;1947.6981067934494;1973.4671638657626;2286.7412695733324;2806.256342069353;2833.2208642623445;9629.422234665872;9838.458884761336;10150.28947973642;10462.895371046268;14506.1296322221;1835.109971663742;1877.3523134518568;1894.3180455036177;1897.5351038995395;1916.6358391905494;77964;78301.60849195774;80463.19536804616;85764.57117714372;86206;10582.682519524427;10827.621033263798;10939.12487001038;11140.610078647209;11197.009599864034;15867.206639668202;15883.2058397082;15912.52262432129;15913.010873640795;15920.601984950468;6901.965490172617;7361.300676435837;7393.260673932564;7705.961470192725;7938.722144724907;6301.212348456443;6442.420182183626;6626.469882409396;6653.700583473756;6700.262971073178;4586.472555656075;4614.330922016289;4633.235516139799;4768.713877167381;4970.502949705001;1725.6721222967847;1809.791873934488;1849.8427633651022;1948.3959972408315;1968.960620787605;416.24036134054865;436.3040949685247;859.6905114158898;902.909709029105;1016.2266844356645;10788;11461.197716159955;11471.942640286745;11564.42177891102;11977.880221197676;429.74000729558793;853.6756032707656;957.6025949231131;966.8308046091905;981.8429051351892;9717.368371055858;10422.218333624856;10457.11114555256;10468.401486988847;10494.790104198026;428880;436810;444418;446005;446424.5896639814;91302.54348728214;94300;94600;96475;97041.51479242559;973.1679414100984;1005.4570531912832;1029.8249297619423;1031.510032734445;1037.3557910711456;15578.9221053894;15996.120213388376;16339;16498.844625653364;16507.83492165111;39582.208355833296;39604.60395396009;40218.798906005286;41063.794681026404;41170.794146030275;58563.70718146382;58783;59111.40888591231;60008.699956499935;60156.699216503635;8127.552984585905;8265.752027439186;8407.579621019047;8463;8569.442986205877;11898.345590992578;12615.936920315708;12628;12676.87323126757;12730.618081457571;10658.680239592515;10708.785824283315;10776.137908967421;11253.887461125283;11388.544458221579;10387.013233742782;10411.947940260554;10504.369737815756;10597.311174773615;10915.290506117077;10431.843522347019;10471.424071675827;10610.469476525988;11098.2786118902;11102.222844400814;8233.46482478637;8375.664973400995;8376.204260595234;8623.741287761377;8926.955365223132;10172.745681358025;10519.526621301906;10581.4709264538;10907.890921091004;11647.76704465923 01:33:31 INFO - PROCESS | 7268 | |3;mootools.html;1465.9633509162272;1487.5760408283638;1609.2516979604482;1767.390250363624;1787.9910600446997;7979.880301795478;8240.217179367966;8491.575421228938;9180.449173049621;9195.126462986014;8438.240558349748;8763.07987661296;8790.208881200691;9027.187553120219;9070.546472676357;2371.2412028150998;2404.7715467030603;2405.2423486601665;2406.3262286559793;2412.3245491262387;2024.8278896293832;2375.7743014413604;2390.4621460171497;2433.3186707721866;2434.9756502435016;2063.4531849060013;2292.3008482412856;2374.3707917401903;2378.143868207444;2383.535210633927;2286.0969916882905;2293.2546922250253;2304.043821813937;2304.665823455606;2310.6418505131733;2308.1113771198043;2310.5378924215224;2315.8809689134423;2317.2700599311165;2320.756320586331;8972.820543589092;9049.592768325441;9097.09029097085;9102.271818254523;9108.134727200906;5053.140966035783;5198.818041368534;5200.609954253408;5208.817691380784;5208.895822083575;3374.240795820945;3414.453687410027;3477.930441391158;3478.6521347865264;3479.3389256041273;1070.6038765656679;1078.0006177082953;1083.2038451737967;1086.5110700184869;1089.4171618184234;12482.188657737219;12584.874151258553;12595.811062834066;12620.368981550977;12625.873741262561;4476.753778542212;4730.62155027597;4842.443119041285;4854.732989685601;4878.390201224847;10545.736356590993;10547.103496202755;10548.208884333706;10550.577976880839;10559.63041293551;5211.114110601131;5218.191180367049;5223.869403264873;5226.869328266747;5231.136862417735;4629.213033784265;4710.576048155683;4825.420949486014;4826.962203126344;4829.830955916596;3948.407738839197;4027.476428064333;4049.372347286175;4097.221527909687;4118.19695159441;1197.8442802435627;1238.052889539503;1323.1597935311147;1342.9798553021712;1356.138851829076;815.604431850552;820.7045463633087;829.0093338460482;858.5106489301038;870.7692461497708;5324.787008519694;5404.756785944642;5427.158790387496;5603.439656034364;5667.4332566743;897.6902968475865;925.0703043441433;939.6100618243489;941.7127776028377;946.2477330522252;3628.2743451309843;3688.8933320003894;3749.2940711975984;3750.6249375062275;3831.865884694078;10605.151587872951;11135.721606959729;11135.721606959729;11139.554417823358;11144.888551114385;11002.33985960845;11028.834567481494;11050.226484146193;11061.889381106086;11079.169062320358;7890.802729931683;8078.474899131656;8269.875951860728;8303.6678532858;8335.708250211213;5633.577481688808;5709.8287051388525;5771.942280577308;5805.187273781589;5929.318128415288;10045.799084018425;10105.696829095139;10117.59529618807;10122.79754404893;10185.9490702546;10445.164386848883;10467.476626168509;10536.894631053592;10582;10673.786524269315;7653.961730191313;8032.959835201021;8217.342612591097;8220.63007164667;8227.670893164206;8471.407001509835;8733.956330218309;8816.294696424398;8823.514706691194;8835;6977.441804655717;7068.611226382598;7114.537555058904;7142.321479459443;7372.778816635295;7110.182329032227;7118.572885626879;7140.143182818095;7180.066591343092;7196.424286057208;6662.733490660319;6673.9332606673315;6682.164729408824;6717.731290748511;6734.292899245509;4651.976740116278;4761.381020467317;4816.831410900601;4828.830990915301;4856.635752318661;4739.928901066418;4842.975785121052;4875.439324477588;4953.578945789648;5078.060558796635 01:33:31 INFO - PROCESS | 7268 | |4;prototype.html;314.713610614341;321.8020917135961;325.87779582656503;326.83331500934526;327.65268815056055;4991.725455099968;5143.5113664201845;5189.481051894809;5254.947450525494;5315.920261196085;4969.62727795415;5084.186530155176;5109.744512774365;5137.460566640496;5144.871378215546;4072.552019277877;4072.902455235556;4082.3060079786505;4083.3466645336753;4093.8362465501345;3975.2248311579256;4074.675730387621;4077.9184416311655;4091.3044782387065;4094.3653733671326;4029.7783621900785;4042.3734321180264;4046.089629833293;4057.431959525669;4067.6339129478342;4026.235015347104;4042.2319759245797;4043.130726893732;4049.1699201663737;4055.3916912463073;3627.6009638939695;3631.110377957391;3632.872849450283;3650.8904732858055;3652.9634703653155;4893.339399181101;4996.925046124311;5056.064628043787;5077.923831142536;5078.619103567247;4576.290674945356;4587.839425620087;4594.19601569724;4596.35651008859;4615.907681846378;5355.6251062425645;5357.142857142878;5370.221317908881;5371.543418809406;5375.838724838261;3674.5590529136407;3859.7684138951754;3878.4596089561383;3899.3622678474826;3928.9803550982347;5558.972205138989;5558.972205138989;5574.136008918665;5593.804216852432;5607.971960140173;3976.304146774303;4004.9199016019516;4004.9787304237234;4011.498562679665;4014.41790940312;3949.2101579683604;3983.46223259862;3991.1219531702977;4059.086705491241;4066.779966010185;4553.840615578505;4554.476235232924;4557.977210113928;4574.405327307429;4595.862124136282;5408.025585927724;5410.08028635133;5413.864653383618;5435.483629055233;5446.128619420873;1321.5242512695422;1334.219481603273;1336.7660659384762;1361.1900918953206;1377.1530508737255;927.2720914082548;936.9250459963187;959.8464245720651;959.9088086631759;977.130353984954;5093.312402825572;5128.487096306599;5173.948260517422;5184;5196.68819870809;5476.945230547643;5478.616496845262;5486.231927530069;5487.64330318528;5527.668339899538;4962.330085438492;5086.949130508721;5128.615353848401;5176.145935920531;5192.273081768555;2519.375003123012;2532.961485790817;2564.230730780758;2574.4336246025846;2590.857502837362;4930.939847932712;4939.357883475125;4948.529889660548;4954.727489988013;4970.751462426864;4662.184117779375;4794.856154315376;4889.779959901813;4896.902061958741;4917.827876024322;4906.239532872411;4949.688332591794;4965.428975667773;4967.286286231244;4987.800487980513;4818.614510839195;4827.831025914076;4836.226203807374;4856.757162141949;4864.878378040577;4591.793369298322;4718.787654555485;4736.537000759655;4765.309030190672;4847.158079929745;4969.701817890938;5017;5030.522100400456;5039.395272567169;5053.242013697828;3657.0308868149427;3663.7801731895106;3682.3739964205615;3688.3360995021153;3689.4281386385155;4743.264793956942;4773.260144677581;4877.756112194447;4927.384076990376;4942.4810394909455;4666.366771629902;4674.74288914113;4713.787879545497;4715.72675377653;4736.692115012651;4685.297205419214;4694.507076756891;4703.9529604704885;4719.890825656037;4744.481765835038;4386.477775279291;4660.6271498279375;4695.812167513262;4729.722974796717;4744.4543877454535;4590.6327493799745;4735.408073990751;4747.952520474751;4752.477227505041;4761.523847615211;4629.629629629689;4655.255159174516;4670.743109129031;4678.438587369537;4726.8109275628585 01:33:31 INFO - PROCESS | 7268 | |5;yui.html;569.3168198162205;573.9024365857804;583.5885700581091;598.1834795504138;619.4270299972525;12315.38423078847;13082.869171308284;13115.344232788359;13130.671733206651;13145.47418103276;12538.122331436804;13121.803172952414;13231.669208269797;13237.470501179965;13239.470421183141;646.3278190681685;786.0606575142692;807.5840941914919;810.2586133687669;811.1726039439768;661.5534514202918;783.165928286376;786.7403756760284;797.696875187428;812.1350761439048;852.7569642651846;857.0786404615033;860.2558786649535;862.7411776467067;863.6286396849353;670.5607826873405;854.478767951549;855.6962278391175;857.0829212742368;857.6097875466647;506.8023470846373;589.6196952965356;596.6211455725602;601.308495230484;612.0329878791499;12765.170263932907;12776.680582985407;12812.871871281355;13159.144655597356;13167.078304518687;12923.806142907864;13450.86549134506;13666.385012674453;13690.657733556642;13775.655608609764;12034.458449369711;12316.13787034908;12317.630471085882;12444.81332780009;12690.492380304777;4115.135821477494;4142.896427589304;4210.179015092058;4218.894527636803;4345.109252603209;76647.61676191584;77367.6131619344;77792.61103694502;80136.59931700304;80590.19409805886;11221.887781122085;11236.831447528293;11290.604828830952;11418.885811141949;11433.313171404714;20322.18711251563;20439.591208175752;20442;20471;20536;7723;7798.727044553413;7825.960870195727;8037.799055023671;8069.798255043671;4101.364288535282;4149.211649786531;4177.895552611149;4311.159323931866;4408.823647054146;2947.1747910585073;3024.894128705485;3034.620672415948;3036.316828713566;3051.5727798108283;582.9708514574254;589.9380565040694;591.7425919724933;594.313567829158;599.0594766216998;487.9853604391874;548.7777450132703;568.8606291458619;581.8914966987895;600.9519238460913;7663.164629087162;7961.761147165595;8124.268815806606;8209.302209312274;8463;522.3001178420934;560.1010378342701;587.2131343999062;603.7886739641091;622.9595076320115;3818.255440189192;3927.5483319418063;4080.693947953856;4085.080856807195;4095.7952102395357;69812.3018769816;70378;70585.64707176431;98810.50594747125;104010;96888;98337.50831245798;103471.4826425863;106095.46952265344;107520;56127.719361403746;58100.70949645225;58411;91126.08873911308;94619.52690236505;7568.772936811904;7705.113911899979;7840.882386764317;7854.096778870503;7874.6850125994315;53058;53578.19632705435;53689.19466208088;54397.72801135969;54450.727746361015;70134;71725.64137179281;78496;79739.60130199311;80441.59779201067;10966.506507207036;11066.667999960015;11076.5569377224;11233.32600044;11251.774964500828;11246.212765106364;11339.319640821577;11373.601923932623;11476;11953.163278570417;10616.203784716023;10909.727081875248;11087.113030957666;11121.555137794398;11250.156238282325;10063.345882517613;10446.582136714447;10484.37492188712;10745.875509481264;10788.784224315626;9776;10206.336588121749;10268.897311027093;10608.416537090534;10738.194635402533;8527.573621318785;9051.14014168653;9075.410098343587;9205.079492050741;9270.306564095714;8154.75535733929;8336.416450848625;8677.479351238946;9029.458232506071;9062.365634405529 01:33:31 INFO - PROCESS | 7268 | __end_tp_report 01:33:31 INFO - PROCESS | 7268 | __start_cc_report 01:33:31 INFO - PROCESS | 7268 | _x_x_mozilla_cycle_collect,1177 01:33:31 INFO - PROCESS | 7268 | __end_cc_report 01:33:31 INFO - PROCESS | 7268 | __startTimestamp1475570011649__endTimestamp 01:33:31 INFO - PROCESS | 7268 | 01:33:31 INFO - PROCESS | 7268 | ------- Summary: start ------- 01:33:31 INFO - PROCESS | 7268 | Number of tests: 6 01:33:31 INFO - PROCESS | 7268 | 01:33:31 INFO - PROCESS | 7268 | [#0] dojo.html Cycles:165 Average:5268.00 Median:5495.89 stddev:603.41 (11.0%) stddev-sans-first:578.54 01:33:31 INFO - PROCESS | 7268 | Values: 3004.2 3033.1 3033.6 3065.9 3084.8 5198.6 5200.7 5273.4 5301.5 5308.5 5294.9 5295.1 5295.2 5323.7 5327.1 4796.0 4803.9 4906.7 4913.4 4925.1 4821.1 4832.1 4838.7 4876.8 4877.7 4919.0 4972.3 4984.8 4986.7 5024.1 4777.1 4817.0 4879.3 4894.4 4949.5 4861.2 4865.1 4865.8 4866.4 4870.4 5264.5 5316.9 5317.5 5322.2 5343.4 5554.6 5602.3 5676.4 5721.1 5726.1 5614.9 5622.5 5667.3 5696.2 5717.3 5168.4 5267.6 5281.3 5302.2 5362.8 5728.5 5737.9 5779.9 5799.6 5814.5 5548.0 5572.4 5584.5 5584.7 5586.4 5514.6 5632.9 5640.0 5640.8 5644.8 5538.9 5588.4 5632.4 5635.9 5742.9 5617.4 5651.4 5662.7 5663.9 5665.6 4269.3 4273.8 4275.7 4281.6 4327.6 3786.8 3792.6 3808.4 3812.7 3820.9 5357.5 5361.0 5375.9 5376.3 5428.5 5653.3 5699.9 5707.7 5714.7 5715.9 5226.5 5271.6 5279.1 5341.0 5432.9 4764.3 4805.7 4809.4 4821.1 4832.7 5802.8 5935.3 5960.8 5962.6 5965.9 5718.4 5722.7 5727.9 5729.7 5735.8 5832.4 5839.5 5882.9 5892.5 5896.1 5452.4 5488.6 5502.4 5556.6 5560.8 5684.9 5685.6 5687.0 5691.0 5742.9 5495.9 5521.4 5526.7 5532.1 5536.7 5387.8 5444.0 5507.8 5514.3 5585.8 5532.6 5547.1 5564.9 5602.1 5621.2 5635.8 5641.9 5644.9 5645.5 5650.2 5323.5 5331.5 5390.4 5513.9 5521.6 01:33:31 INFO - PROCESS | 7268 | 01:33:31 INFO - PROCESS | 7268 | [#1] ext.html Cycles:180 Average:58487.38 Median:36598.95 stddev:118175.16 (322.9%) stddev-sans-first:118426.63 01:33:31 INFO - PROCESS | 7268 | Values: 555.6 602.1 614.1 614.7 617.2 34082.0 34692.7 34801.8 34804.0 41375.0 43541.8 43730.8 43786.0 43898.6 43899.6 8788.7 8950.4 8953.7 8956.9 8959.0 7938.8 8238.2 8834.3 8841.2 8938.7 10425.2 10678.5 10678.6 11018.9 11022.7 10213.3 10242.1 10268.5 10292.0 10365.0 10590.1 10649.6 10652.5 10654.1 10659.7 41645.8 41765.2 41780.2 41910.8 41927.2 2987.8 3022.4 3034.4 3068.7 3071.6 31027.5 31030.1 31295.0 31550.7 31820.4 3981.7 4011.6 4026.1 4173.8 4180.4 319504.0 321756.0 321775.0 321850.0 322701.0 55598.0 55885.0 55896.4 55931.7 55952.0 34795.0 36147.3 58740.4 58770.4 58897.9 15604.3 15724.9 15765.1 15772.8 15783.1 11811.2 11891.2 11900.5 11901.5 11902.8 15803.0 16392.3 17869.0 18411.9 18572.9 6965.4 7017.3 7172.8 7191.8 7248.7 790.5 873.0 876.9 918.4 955.4 25816.6 27003.3 27238.5 30538.7 32105.2 1053.4 1085.6 1094.2 1161.3 1161.7 15796.7 16440.0 16441.8 16525.8 16613.8 500426.0 502967.0 506706.0 508286.0 508314.0 55070.2 55667.4 55699.7 55713.0 55742.7 1309.4 1327.6 1341.8 1348.6 1358.1 27750.7 29659.6 29742.4 29852.4 30141.8 49115.5 50116.5 50226.2 50257.0 50284.5 483278.0 484207.0 484661.0 484903.0 487158.3 23726.3 24401.1 24634.5 24836.4 25812.1 40088.8 44054.3 44491.6 44989.6 45733.3 37761.8 38854.2 39163.4 39267.8 40534.0 37050.6 37969.4 38078.8 38986.4 39627.4 38215.4 38775.2 39923.2 40360.6 40429.4 30194.8 34240.3 34511.8 35538.0 35617.1 23187.1 23744.3 23952.5 24051.8 24160.9 01:33:31 INFO - PROCESS | 7268 | 01:33:31 INFO - PROCESS | 7268 | [#2] jquery.html Cycles:180 Average:27093.75 Median:20312.99 stddev:73142.42 (360.1%) stddev-sans-first:73320.14 01:33:31 INFO - PROCESS | 7268 | Values: 397.2 407.2 407.3 414.2 429.7 13090.9 17523.6 18855.0 19497.2 19510.7 13869.4 13940.0 16436.1 16623.5 17385.8 5486.4 5520.9 5775.3 5798.1 5908.0 5749.8 5805.9 5810.6 5818.9 5823.4 6399.0 6447.1 6449.5 6452.4 6457.8 5803.9 5845.0 6126.4 6444.0 6458.5 5674.3 5675.3 5677.8 5678.6 5679.2 13148.9 20406.4 21250.5 21317.5 22331.0 1947.7 1973.5 2286.7 2806.3 2833.2 9629.4 9838.5 10150.3 10462.9 14506.1 1835.1 1877.4 1894.3 1897.5 1916.6 77964.0 78301.6 80463.2 85764.6 86206.0 10582.7 10827.6 10939.1 11140.6 11197.0 15867.2 15883.2 15912.5 15913.0 15920.6 6902.0 7361.3 7393.3 7706.0 7938.7 6301.2 6442.4 6626.5 6653.7 6700.3 4586.5 4614.3 4633.2 4768.7 4970.5 1725.7 1809.8 1849.8 1948.4 1969.0 416.2 436.3 859.7 902.9 1016.2 10788.0 11461.2 11471.9 11564.4 11977.9 429.7 853.7 957.6 966.8 981.8 9717.4 10422.2 10457.1 10468.4 10494.8 428880.0 436810.0 444418.0 446005.0 446424.6 91302.5 94300.0 94600.0 96475.0 97041.5 973.2 1005.5 1029.8 1031.5 1037.4 15578.9 15996.1 16339.0 16498.8 16507.8 39582.2 39604.6 40218.8 41063.8 41170.8 58563.7 58783.0 59111.4 60008.7 60156.7 8127.6 8265.8 8407.6 8463.0 8569.4 11898.3 12615.9 12628.0 12676.9 12730.6 10658.7 10708.8 10776.1 11253.9 11388.5 10387.0 10411.9 10504.4 10597.3 10915.3 10431.8 10471.4 10610.5 11098.3 11102.2 8233.5 8375.7 8376.2 8623.7 8927.0 10172.7 10519.5 10581.5 10907.9 11647.8 01:33:31 INFO - PROCESS | 7268 | 01:33:31 INFO - PROCESS | 7268 | [#3] mootools.html Cycles:180 Average:5772.62 Median:4750.65 stddev:3355.19 (70.6%) stddev-sans-first:3348.99 01:33:31 INFO - PROCESS | 7268 | Values: 1466.0 1487.6 1609.3 1767.4 1788.0 7979.9 8240.2 8491.6 9180.4 9195.1 8438.2 8763.1 8790.2 9027.2 9070.5 2371.2 2404.8 2405.2 2406.3 2412.3 2024.8 2375.8 2390.5 2433.3 2435.0 2063.5 2292.3 2374.4 2378.1 2383.5 2286.1 2293.3 2304.0 2304.7 2310.6 2308.1 2310.5 2315.9 2317.3 2320.8 8972.8 9049.6 9097.1 9102.3 9108.1 5053.1 5198.8 5200.6 5208.8 5208.9 3374.2 3414.5 3477.9 3478.7 3479.3 1070.6 1078.0 1083.2 1086.5 1089.4 12482.2 12584.9 12595.8 12620.4 12625.9 4476.8 4730.6 4842.4 4854.7 4878.4 10545.7 10547.1 10548.2 10550.6 10559.6 5211.1 5218.2 5223.9 5226.9 5231.1 4629.2 4710.6 4825.4 4827.0 4829.8 3948.4 4027.5 4049.4 4097.2 4118.2 1197.8 1238.1 1323.2 1343.0 1356.1 815.6 820.7 829.0 858.5 870.8 5324.8 5404.8 5427.2 5603.4 5667.4 897.7 925.1 939.6 941.7 946.2 3628.3 3688.9 3749.3 3750.6 3831.9 10605.2 11135.7 11135.7 11139.6 11144.9 11002.3 11028.8 11050.2 11061.9 11079.2 7890.8 8078.5 8269.9 8303.7 8335.7 5633.6 5709.8 5771.9 5805.2 5929.3 10045.8 10105.7 10117.6 10122.8 10185.9 10445.2 10467.5 10536.9 10582.0 10673.8 7654.0 8033.0 8217.3 8220.6 8227.7 8471.4 8734.0 8816.3 8823.5 8835.0 6977.4 7068.6 7114.5 7142.3 7372.8 7110.2 7118.6 7140.1 7180.1 7196.4 6662.7 6673.9 6682.2 6717.7 6734.3 4652.0 4761.4 4816.8 4828.8 4856.6 4739.9 4843.0 4875.4 4953.6 5078.1 01:33:31 INFO - PROCESS | 7268 | 01:33:31 INFO - PROCESS | 7268 | [#4] prototype.html Cycles:180 Average:4299.77 Median:4732.57 stddev:1210.13 (25.6%) stddev-sans-first:1175.98 01:33:31 INFO - PROCESS | 7268 | Values: 314.7 321.8 325.9 326.8 327.7 4991.7 5143.5 5189.5 5254.9 5315.9 4969.6 5084.2 5109.7 5137.5 5144.9 4072.6 4072.9 4082.3 4083.3 4093.8 3975.2 4074.7 4077.9 4091.3 4094.4 4029.8 4042.4 4046.1 4057.4 4067.6 4026.2 4042.2 4043.1 4049.2 4055.4 3627.6 3631.1 3632.9 3650.9 3653.0 4893.3 4996.9 5056.1 5077.9 5078.6 4576.3 4587.8 4594.2 4596.4 4615.9 5355.6 5357.1 5370.2 5371.5 5375.8 3674.6 3859.8 3878.5 3899.4 3929.0 5559.0 5559.0 5574.1 5593.8 5608.0 3976.3 4004.9 4005.0 4011.5 4014.4 3949.2 3983.5 3991.1 4059.1 4066.8 4553.8 4554.5 4558.0 4574.4 4595.9 5408.0 5410.1 5413.9 5435.5 5446.1 1321.5 1334.2 1336.8 1361.2 1377.2 927.3 936.9 959.8 959.9 977.1 5093.3 5128.5 5173.9 5184.0 5196.7 5476.9 5478.6 5486.2 5487.6 5527.7 4962.3 5086.9 5128.6 5176.1 5192.3 2519.4 2533.0 2564.2 2574.4 2590.9 4930.9 4939.4 4948.5 4954.7 4970.8 4662.2 4794.9 4889.8 4896.9 4917.8 4906.2 4949.7 4965.4 4967.3 4987.8 4818.6 4827.8 4836.2 4856.8 4864.9 4591.8 4718.8 4736.5 4765.3 4847.2 4969.7 5017.0 5030.5 5039.4 5053.2 3657.0 3663.8 3682.4 3688.3 3689.4 4743.3 4773.3 4877.8 4927.4 4942.5 4666.4 4674.7 4713.8 4715.7 4736.7 4685.3 4694.5 4704.0 4719.9 4744.5 4386.5 4660.6 4695.8 4729.7 4744.5 4590.6 4735.4 4748.0 4752.5 4761.5 4629.6 4655.3 4670.7 4678.4 4726.8 01:33:31 INFO - PROCESS | 7268 | 01:33:31 INFO - PROCESS | 7268 | [#5] yui.html Cycles:180 Average:18869.88 Median:27499.75 stddev:27705.80 (100.7%) stddev-sans-first:27749.44 01:33:31 INFO - PROCESS | 7268 | Values: 569.3 573.9 583.6 598.2 619.4 12315.4 13082.9 13115.3 13130.7 13145.5 12538.1 13121.8 13231.7 13237.5 13239.5 646.3 786.1 807.6 810.3 811.2 661.6 783.2 786.7 797.7 812.1 852.8 857.1 860.3 862.7 863.6 670.6 854.5 855.7 857.1 857.6 506.8 589.6 596.6 601.3 612.0 12765.2 12776.7 12812.9 13159.1 13167.1 12923.8 13450.9 13666.4 13690.7 13775.7 12034.5 12316.1 12317.6 12444.8 12690.5 4115.1 4142.9 4210.2 4218.9 4345.1 76647.6 77367.6 77792.6 80136.6 80590.2 11221.9 11236.8 11290.6 11418.9 11433.3 20322.2 20439.6 20442.0 20471.0 20536.0 7723.0 7798.7 7826.0 8037.8 8069.8 4101.4 4149.2 4177.9 4311.2 4408.8 2947.2 3024.9 3034.6 3036.3 3051.6 583.0 589.9 591.7 594.3 599.1 488.0 548.8 568.9 581.9 601.0 7663.2 7961.8 8124.3 8209.3 8463.0 522.3 560.1 587.2 603.8 623.0 3818.3 3927.5 4080.7 4085.1 4095.8 69812.3 70378.0 70585.6 98810.5 104010.0 96888.0 98337.5 103471.5 106095.5 107520.0 56127.7 58100.7 58411.0 91126.1 94619.5 7568.8 7705.1 7840.9 7854.1 7874.7 53058.0 53578.2 53689.2 54397.7 54450.7 70134.0 71725.6 78496.0 79739.6 80441.6 10966.5 11066.7 11076.6 11233.3 11251.8 11246.2 11339.3 11373.6 11476.0 11953.2 10616.2 10909.7 11087.1 11121.6 11250.2 10063.3 10446.6 10484.4 10745.9 10788.8 9776.0 10206.3 10268.9 10608.4 10738.2 8527.6 9051.1 9075.4 9205.1 9270.3 8154.8 8336.4 8677.5 9029.5 9062.4 01:33:31 INFO - PROCESS | 7268 | -------- Summary: end -------- 01:33:31 INFO - PROCESS | 7268 | 01:33:32 INFO - TEST-INFO | 7268: exit 0 01:33:32 INFO - TEST-OK | dromaeo_css | took 1117580ms 01:33:32 INFO - TEST-START | kraken 01:33:32 INFO - operating with platform_type : linux_ 01:33:32 INFO - Initialising browser for kraken test... 01:33:32 INFO - TEST-INFO | started process 7576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU7qRoP/profile http://localhost:58400/getInfo.html) 01:33:37 INFO - PROCESS | 7576 | __metrics Screen width/height:1600/1200 01:33:37 INFO - PROCESS | 7576 | colorDepth:24 01:33:37 INFO - PROCESS | 7576 | Browser inner width/height: 1024/697 01:33:37 INFO - PROCESS | 7576 | __metrics 01:33:37 INFO - PROCESS | 7576 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:33:37 INFO - PROCESS | 7576 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:33:38 INFO - PROCESS | 7576 | console.error: PushService: 01:33:38 INFO - PROCESS | 7576 | stateChangeProcessEnqueue: Error transitioning state 01:33:38 INFO - PROCESS | 7576 | UnknownError 01:33:38 INFO - TEST-INFO | 7576: exit 0 01:33:38 INFO - Browser initialized. 01:33:38 INFO - Running cycle 1/1 for kraken test... 01:33:38 INFO - TEST-INFO | started process 7659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU7qRoP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:33:51 INFO - PROCESS | 7659 | RSS: Main: 173551616 01:33:51 INFO - PROCESS | 7659 | 01:33:53 INFO - PROCESS | 7659 | Cycle 1(1): loaded http://localhost:58400/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58400/tests/kraken/driver.html?testName=audio-beat-detection) 01:33:54 INFO - PROCESS | 7659 | RSS: Main: 232329216 01:33:54 INFO - PROCESS | 7659 | 01:33:57 INFO - PROCESS | 7659 | Cycle 1(1): loaded http://localhost:58400/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58400/tests/kraken/driver.html?testName=audio-dft) 01:33:57 INFO - PROCESS | 7659 | RSS: Main: 217165824 01:33:57 INFO - PROCESS | 7659 | 01:34:00 INFO - PROCESS | 7659 | Cycle 1(1): loaded http://localhost:58400/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58400/tests/kraken/driver.html?testName=audio-fft) 01:34:01 INFO - PROCESS | 7659 | RSS: Main: 298958848 01:34:01 INFO - PROCESS | 7659 | 01:34:03 INFO - PROCESS | 7659 | Cycle 1(1): loaded http://localhost:58400/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58400/tests/kraken/driver.html?testName=audio-oscillator) 01:34:04 INFO - PROCESS | 7659 | RSS: Main: 207745024 01:34:04 INFO - PROCESS | 7659 | 01:34:06 INFO - PROCESS | 7659 | Cycle 1(1): loaded http://localhost:58400/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58400/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:34:07 INFO - PROCESS | 7659 | RSS: Main: 212578304 01:34:07 INFO - PROCESS | 7659 | 01:34:10 INFO - PROCESS | 7659 | Cycle 1(1): loaded http://localhost:58400/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58400/tests/kraken/driver.html?testName=imaging-darkroom) 01:34:10 INFO - PROCESS | 7659 | RSS: Main: 248938496 01:34:10 INFO - PROCESS | 7659 | 01:34:14 INFO - PROCESS | 7659 | Cycle 1(1): loaded http://localhost:58400/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58400/tests/kraken/driver.html?testName=imaging-desaturate) 01:34:14 INFO - PROCESS | 7659 | RSS: Main: 248107008 01:34:14 INFO - PROCESS | 7659 | 01:34:17 INFO - PROCESS | 7659 | Cycle 1(1): loaded http://localhost:58400/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58400/tests/kraken/driver.html?testName=json-parse-financial) 01:34:18 INFO - PROCESS | 7659 | RSS: Main: 247971840 01:34:18 INFO - PROCESS | 7659 | 01:34:19 INFO - PROCESS | 7659 | Cycle 1(1): loaded http://localhost:58400/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58400/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:34:20 INFO - PROCESS | 7659 | RSS: Main: 210681856 01:34:20 INFO - PROCESS | 7659 | 01:34:21 INFO - PROCESS | 7659 | Cycle 1(1): loaded http://localhost:58400/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58400/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:34:22 INFO - PROCESS | 7659 | RSS: Main: 217640960 01:34:22 INFO - PROCESS | 7659 | 01:34:24 INFO - PROCESS | 7659 | Cycle 1(1): loaded http://localhost:58400/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58400/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:34:25 INFO - PROCESS | 7659 | RSS: Main: 227491840 01:34:25 INFO - PROCESS | 7659 | 01:34:27 INFO - PROCESS | 7659 | Cycle 1(1): loaded http://localhost:58400/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:34:28 INFO - PROCESS | 7659 | RSS: Main: 236257280 01:34:28 INFO - PROCESS | 7659 | 01:34:31 INFO - PROCESS | 7659 | Cycle 1(1): loaded http://localhost:58400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:34:31 INFO - PROCESS | 7659 | RSS: Main: 233152512 01:34:31 INFO - PROCESS | 7659 | 01:34:33 INFO - PROCESS | 7659 | Cycle 1(1): loaded http://localhost:58400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58400/tests/kraken/driver.html?testName=ai-astar) 01:34:33 INFO - PROCESS | 7659 | RSS: Main: 284426240 01:34:33 INFO - PROCESS | 7659 | 01:34:33 INFO - PROCESS | 7659 | __start_tp_report 01:34:33 INFO - PROCESS | 7659 | _x_x_mozilla_page_load 01:34:33 INFO - PROCESS | 7659 | _x_x_mozilla_page_load_details 01:34:33 INFO - PROCESS | 7659 | |i|pagename|runs| 01:34:33 INFO - PROCESS | 7659 | |0;ai-astar;110;111;112;111;110;112;110;111;111;112 01:34:33 INFO - PROCESS | 7659 | |1;audio-beat-detection;156;131;123;173;126;124;124;127;153;124 01:34:33 INFO - PROCESS | 7659 | |2;audio-dft;161;161;159;162;162;161;162;161;160;161 01:34:33 INFO - PROCESS | 7659 | |3;audio-fft;75;76;75;116;77;78;88;77;98;76 01:34:33 INFO - PROCESS | 7659 | |4;audio-oscillator;82;83;108;83;83;83;115;83;83;109 01:34:33 INFO - PROCESS | 7659 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;117;117;116 01:34:33 INFO - PROCESS | 7659 | |6;imaging-darkroom;147;147;147;148;146;146;147;146;146;146 01:34:33 INFO - PROCESS | 7659 | |7;imaging-desaturate;98;96;95;95;95;95;95;95;95;95 01:34:33 INFO - PROCESS | 7659 | |8;json-parse-financial;53;50;51;56;52;53;52;53;51;53 01:34:33 INFO - PROCESS | 7659 | |9;json-stringify-tinderbox;61;62;60;61;62;61;60;61;64;62 01:34:33 INFO - PROCESS | 7659 | |10;stanford-crypto-aes;81;89;83;80;80;80;80;78;78;80 01:34:33 INFO - PROCESS | 7659 | |11;stanford-crypto-ccm;132;129;136;136;140;131;131;132;163;133 01:34:33 INFO - PROCESS | 7659 | |12;stanford-crypto-pbkdf2;172;165;166;167;168;169;169;172;168;166 01:34:33 INFO - PROCESS | 7659 | |13;stanford-crypto-sha256-iterative;67;65;66;66;66;66;79;67;66;66 01:34:33 INFO - PROCESS | 7659 | __end_tp_report 01:34:33 INFO - PROCESS | 7659 | __start_cc_report 01:34:33 INFO - PROCESS | 7659 | _x_x_mozilla_cycle_collect,1655 01:34:33 INFO - PROCESS | 7659 | __end_cc_report 01:34:33 INFO - PROCESS | 7659 | __startTimestamp1475570073907__endTimestamp 01:34:33 INFO - PROCESS | 7659 | 01:34:33 INFO - PROCESS | 7659 | ------- Summary: start ------- 01:34:33 INFO - PROCESS | 7659 | Number of tests: 14 01:34:33 INFO - PROCESS | 7659 | 01:34:33 INFO - PROCESS | 7659 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 01:34:33 INFO - PROCESS | 7659 | Values: 110.0 111.0 112.0 111.0 110.0 112.0 110.0 111.0 111.0 112.0 01:34:33 INFO - PROCESS | 7659 | 01:34:33 INFO - PROCESS | 7659 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:129.00 stddev:17.84 (13.8%) stddev-sans-first:17.41 01:34:33 INFO - PROCESS | 7659 | Values: 156.0 131.0 123.0 173.0 126.0 124.0 124.0 127.0 153.0 124.0 01:34:33 INFO - PROCESS | 7659 | 01:34:33 INFO - PROCESS | 7659 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 01:34:33 INFO - PROCESS | 7659 | Values: 161.0 161.0 159.0 162.0 162.0 161.0 162.0 161.0 160.0 161.0 01:34:33 INFO - PROCESS | 7659 | 01:34:33 INFO - PROCESS | 7659 | [#3] audio-fft Cycles:10 Average:83.60 Median:77.00 stddev:13.57 (17.6%) stddev-sans-first:14.04 01:34:33 INFO - PROCESS | 7659 | Values: 75.0 76.0 75.0 116.0 77.0 78.0 88.0 77.0 98.0 76.0 01:34:33 INFO - PROCESS | 7659 | 01:34:33 INFO - PROCESS | 7659 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:83.00 stddev:13.55 (16.3%) stddev-sans-first:13.96 01:34:33 INFO - PROCESS | 7659 | Values: 82.0 83.0 108.0 83.0 83.0 83.0 115.0 83.0 83.0 109.0 01:34:33 INFO - PROCESS | 7659 | 01:34:33 INFO - PROCESS | 7659 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 01:34:33 INFO - PROCESS | 7659 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 01:34:33 INFO - PROCESS | 7659 | 01:34:33 INFO - PROCESS | 7659 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 01:34:33 INFO - PROCESS | 7659 | Values: 147.0 147.0 147.0 148.0 146.0 146.0 147.0 146.0 146.0 146.0 01:34:33 INFO - PROCESS | 7659 | 01:34:33 INFO - PROCESS | 7659 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.97 (1.0%) stddev-sans-first:0.33 01:34:33 INFO - PROCESS | 7659 | Values: 98.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 01:34:33 INFO - PROCESS | 7659 | 01:34:33 INFO - PROCESS | 7659 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:53.00 stddev:1.65 (3.1%) stddev-sans-first:1.73 01:34:33 INFO - PROCESS | 7659 | Values: 53.0 50.0 51.0 56.0 52.0 53.0 52.0 53.0 51.0 53.0 01:34:33 INFO - PROCESS | 7659 | 01:34:33 INFO - PROCESS | 7659 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:1.17 (1.9%) stddev-sans-first:1.24 01:34:33 INFO - PROCESS | 7659 | Values: 61.0 62.0 60.0 61.0 62.0 61.0 60.0 61.0 64.0 62.0 01:34:33 INFO - PROCESS | 7659 | 01:34:33 INFO - PROCESS | 7659 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.00 stddev:3.18 (4.0%) stddev-sans-first:3.37 01:34:33 INFO - PROCESS | 7659 | Values: 81.0 89.0 83.0 80.0 80.0 80.0 80.0 78.0 78.0 80.0 01:34:33 INFO - PROCESS | 7659 | 01:34:33 INFO - PROCESS | 7659 | [#11] stanford-crypto-ccm Cycles:10 Average:136.30 Median:134.50 stddev:9.91 (7.4%) stddev-sans-first:10.39 01:34:33 INFO - PROCESS | 7659 | Values: 132.0 129.0 136.0 136.0 140.0 131.0 131.0 132.0 163.0 133.0 01:34:33 INFO - PROCESS | 7659 | 01:34:33 INFO - PROCESS | 7659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:168.50 stddev:2.39 (1.4%) stddev-sans-first:2.11 01:34:33 INFO - PROCESS | 7659 | Values: 172.0 165.0 166.0 167.0 168.0 169.0 169.0 172.0 168.0 166.0 01:34:33 INFO - PROCESS | 7659 | 01:34:33 INFO - PROCESS | 7659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:66.00 stddev:4.12 (6.2%) stddev-sans-first:4.36 01:34:33 INFO - PROCESS | 7659 | Values: 67.0 65.0 66.0 66.0 66.0 66.0 79.0 67.0 66.0 66.0 01:34:33 INFO - PROCESS | 7659 | -------- Summary: end -------- 01:34:33 INFO - PROCESS | 7659 | 01:34:35 INFO - TEST-INFO | 7659: exit 0 01:34:35 INFO - TEST-OK | kraken | took 62528ms 01:34:35 INFO - SUITE-END | took 1180s 01:34:35 INFO - Completed test suite (00:19:40) 01:34:35 INFO - javascript benchmark 01:34:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3004.2489377655584, 3033.0597514770416, 3033.590465287187, 3065.8620362083702, 3084.7994880332776, 5198.610104242178, 5200.661956972799, 5273.367195936493, 5301.469853014702, 5308.495692909172, 5294.92057619136, 5295.099833028385, 5295.205719142131, 5323.733813309329, 5327.067763141445, 4796.040791841637, 4803.855884323476, 4906.705597664134, 4913.434954980169, 4925.113479573675, 4821.108095002436, 4832.130216561018, 4838.661293709441, 4876.829310974116, 4877.70733755974, 4918.950810491903, 4972.279019542164, 4984.75076246188, 4986.700797952117, 5024.095662780698, 4777.06847164803, 4817.036592681443, 4879.316895634614, 4894.363732714724, 4949.50504949504, 4861.197902346109, 4865.148598995197, 4865.756712164378, 4866.440359358684, 4870.415550133971, 5264.473552644743, 5316.867078323035, 5317.494837990384, 5322.2282768998275, 5343.412224655285, 5554.638948468337, 5602.299712535933, 5676.403977582336, 5721.141828725683, 5726.141078838166, 5614.887702245973, 5622.49397554218, 5667.348254950651, 5696.202531645573, 5717.313922329306, 5168.379794424618, 5267.578593712494, 5281.313429254211, 5302.2046692996355, 5362.839114826562, 5728.455796699307, 5737.913931291034, 5779.942200577941, 5799.5650326225705, 5814.476697097281, 5547.972260138674, 5572.359178694502, 5584.46947539983, 5584.692841893735, 5586.441355864381, 5514.558835293167, 5632.887342253132, 5640.041192997201, 5640.802571910045, 5644.8024319148635, 5538.889222215533, 5588.385277619459, 5632.3804381518, 5635.8591035224445, 5742.885142297131, 5617.41017193197, 5651.378348381675, 5662.66024038559, 5663.858403539944, 5665.575081868877, 4269.338252570795, 4273.807678654468, 4275.657947364266, 4281.593248641374, 4327.632151267115, 3786.8295926683363, 3792.60177681345, 3808.352580061396, 3812.694984401241, 3820.8662696806036, 5357.517823395913, 5360.973195133999, 5375.9462405376225, 5376.327959005124, 5428.457154284619, 5653.293338332708, 5699.886002279931, 5707.743151558107, 5714.714264286769, 5715.857103572361, 5226.529612334908, 5271.551918087006, 5279.128943724242, 5341.038613049688, 5432.891342173134, 4764.309175169581, 4805.663603547788, 4809.350737650442, 4821.083994041121, 4832.685875418087, 5802.767889284466, 5935.347111817697, 5960.837636660896, 5962.552808539377, 5965.850853728692, 5718.399568045295, 5722.656640601577, 5727.914081288867, 5729.684867332337, 5735.799247026334, 5832.387599302012, 5839.532837372915, 5882.852928676817, 5892.469677729025, 5896.056630939201, 5452.400235973961, 5488.560915126701, 5502.367227768857, 5556.638818476786, 5560.805371812129, 5684.857878553069, 5685.602007859576, 5687.033204355187, 5691.0, 5742.856428589319, 5495.890082198413, 5521.420250873601, 5526.696031718294, 5532.114861622121, 5536.695481748542, 5387.838364849061, 5444.047291724011, 5507.834764957058, 5514.338279406497, 5585.832425027255, 5532.585056120726, 5547.084731019337, 5564.860878478071, 5602.1036634138345, 5621.213030175697, 5635.830925072254, 5641.9435805641415, 5644.887102258014, 5645.520130788929, 5650.23721797552, 5323.547498462674, 5331.5201631853315, 5390.380106287827, 5513.9448605513435, 5521.641093328921], "value": 5226.508584303089, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.591640144494, 602.0517684646682, 614.1494030767386, 614.7141579165688, 617.1575799034317, 34081.97754067376, 34692.65307346926, 34801.82599087004, 34804.0, 41375.0, 43541.78229108858, 43730.7813460933, 43786.0, 43898.561014389845, 43899.56100438994, 8788.69239576615, 8950.41822281553, 8953.686620968267, 8956.8656470153, 8959.0, 7938.761837144895, 8238.217369349932, 8834.293256539462, 8841.248493877996, 8938.731838044836, 10425.218108641882, 10678.51946662402, 10678.572857085746, 11018.944905275463, 11022.724431889186, 10213.33613315132, 10242.129418999393, 10268.486575671186, 10292.0, 10365.0, 10590.09984151348, 10649.627263045757, 10652.467376631137, 10654.09440197584, 10659.733506662318, 41645.79177104125, 41765.1646967062, 41780.1643967122, 41910.79044604788, 41927.16145677069, 2987.835669038202, 3022.425739109562, 3034.408290383376, 3068.7391571716207, 3071.5853359796365, 31027.53458698121, 31030.0690979271, 31295.0, 31550.684493155233, 31820.36359272825, 3981.7411868228473, 4011.5587285398583, 4026.1142548639255, 4173.791310434466, 4180.372944058385, 319504.0, 321756.0, 321775.0, 321850.0, 322701.0, 55598.0, 55885.0, 55896.44103558994, 55931.720341398846, 55952.0, 34795.0, 36147.27705445876, 58740.412595874346, 58770.41229587735, 58897.87714860004, 15604.29780659873, 15724.921375393049, 15765.132917689638, 15772.842271577367, 15783.053016819027, 11811.232269902428, 11891.227070240408, 11900.523979040741, 11901.464434100486, 11902.821457678141, 15803.0, 16392.344306227857, 17869.0, 18411.94937113833, 18572.88562686216, 6965.442764578822, 7017.298270172942, 7172.820679483055, 7191.7842464726145, 7248.710051597877, 790.5493868495017, 872.956352182401, 876.8991565969867, 918.3525614441802, 955.3538586951086, 25816.612750808752, 27003.324916877235, 27238.45523089527, 30538.69461305403, 32105.197370065936, 1053.394298278493, 1085.6146068145852, 1094.1902991786021, 1161.3380373187201, 1161.6805378520974, 15796.684066318609, 16440.0, 16441.753373699405, 16525.83474165243, 16613.833861661227, 500426.0, 502967.0, 506706.0, 508286.0, 508314.0, 55070.173947390824, 55667.44332556704, 55699.72150139223, 55713.0, 55742.72128639331, 1309.4107651556646, 1327.5685402244117, 1341.8322709661293, 1348.5954213736036, 1358.110437663332, 27750.72249277562, 29659.555106673848, 29742.405151897274, 29852.402951940407, 30141.849290753406, 49115.50884491109, 50116.498835012644, 50226.24660630167, 50257.0, 50284.49715502798, 483278.0, 484207.0, 484661.0, 484903.0, 487158.334708257, 23726.288211353687, 24401.145959891317, 24634.507309853343, 24836.37909052288, 25812.09657661973, 40088.7995560032, 44054.33918491161, 44491.555084448744, 44989.550104498536, 45733.314000289356, 37761.811190944965, 38854.222915540966, 39163.41254881122, 39267.80366098151, 40534.0, 37050.62949370472, 37969.43045854259, 38078.80960595179, 38986.4152037714, 39627.405588915615, 38215.42676859905, 38775.21433749026, 39923.201535969696, 40360.59639403568, 40429.39355909605, 30194.84902575473, 34240.315193696486, 34511.82744086264, 35538.0, 35617.1095722609, 23187.101612298462, 23744.287671369886, 23952.52094958126, 24051.75948240565, 24160.87919560391], "value": 19275.156305619817, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.1936967955052, 407.18359688823904, 407.338075627106, 414.1571901181097, 429.74215470717576, 13090.869091309083, 17523.561910952216, 18855.0, 19497.220111195555, 19510.707339389886, 13869.4452221911, 13940.0, 16436.096014719187, 16623.50129496114, 17385.82614173858, 5486.3690675572325, 5520.889582208353, 5775.3358363788075, 5798.130280457923, 5907.970460147693, 5749.770009199627, 5805.912911306334, 5810.56420768442, 5818.883622327551, 5823.446772556622, 6399.008153736155, 6447.065175549543, 6449.48404127671, 6452.354764523557, 6457.806265812033, 5803.883922321572, 5844.970775146139, 6126.387361263883, 6444.0, 6458.515611329169, 5674.319081710221, 5675.262215911946, 5677.772889084432, 5678.630888992202, 5679.2333035040565, 13148.86851131486, 20406.387808365773, 21250.468738281514, 21317.467063323387, 22331.0, 1947.6981067934494, 1973.4671638657626, 2286.7412695733324, 2806.256342069353, 2833.2208642623445, 9629.422234665872, 9838.458884761336, 10150.28947973642, 10462.895371046268, 14506.1296322221, 1835.109971663742, 1877.3523134518568, 1894.3180455036177, 1897.5351038995395, 1916.6358391905494, 77964.0, 78301.60849195774, 80463.19536804616, 85764.57117714372, 86206.0, 10582.682519524427, 10827.621033263798, 10939.12487001038, 11140.610078647209, 11197.009599864034, 15867.206639668202, 15883.2058397082, 15912.52262432129, 15913.010873640795, 15920.601984950468, 6901.965490172617, 7361.300676435837, 7393.260673932564, 7705.961470192725, 7938.722144724907, 6301.212348456443, 6442.420182183626, 6626.469882409396, 6653.700583473756, 6700.262971073178, 4586.472555656075, 4614.330922016289, 4633.235516139799, 4768.713877167381, 4970.502949705001, 1725.6721222967847, 1809.791873934488, 1849.8427633651022, 1948.3959972408315, 1968.960620787605, 416.24036134054865, 436.3040949685247, 859.6905114158898, 902.909709029105, 1016.2266844356645, 10788.0, 11461.197716159955, 11471.942640286745, 11564.42177891102, 11977.880221197676, 429.74000729558793, 853.6756032707656, 957.6025949231131, 966.8308046091905, 981.8429051351892, 9717.368371055858, 10422.218333624856, 10457.11114555256, 10468.401486988847, 10494.790104198026, 428880.0, 436810.0, 444418.0, 446005.0, 446424.5896639814, 91302.54348728214, 94300.0, 94600.0, 96475.0, 97041.51479242559, 973.1679414100984, 1005.4570531912832, 1029.8249297619423, 1031.510032734445, 1037.3557910711456, 15578.9221053894, 15996.120213388376, 16339.0, 16498.844625653364, 16507.83492165111, 39582.208355833296, 39604.60395396009, 40218.798906005286, 41063.794681026404, 41170.794146030275, 58563.70718146382, 58783.0, 59111.40888591231, 60008.699956499935, 60156.699216503635, 8127.552984585905, 8265.752027439186, 8407.579621019047, 8463.0, 8569.442986205877, 11898.345590992578, 12615.936920315708, 12628.0, 12676.87323126757, 12730.618081457571, 10658.680239592515, 10708.785824283315, 10776.137908967421, 11253.887461125283, 11388.544458221579, 10387.013233742782, 10411.947940260554, 10504.369737815756, 10597.311174773615, 10915.290506117077, 10431.843522347019, 10471.424071675827, 10610.469476525988, 11098.2786118902, 11102.222844400814, 8233.46482478637, 8375.664973400995, 8376.204260595234, 8623.741287761377, 8926.955365223132, 10172.745681358025, 10519.526621301906, 10581.4709264538, 10907.890921091004, 11647.76704465923], "value": 8711.736308899588, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1465.9633509162272, 1487.5760408283638, 1609.2516979604482, 1767.390250363624, 1787.9910600446997, 7979.880301795478, 8240.217179367966, 8491.575421228938, 9180.449173049621, 9195.126462986014, 8438.240558349748, 8763.07987661296, 8790.208881200691, 9027.187553120219, 9070.546472676357, 2371.2412028150998, 2404.7715467030603, 2405.2423486601665, 2406.3262286559793, 2412.3245491262387, 2024.8278896293832, 2375.7743014413604, 2390.4621460171497, 2433.3186707721866, 2434.9756502435016, 2063.4531849060013, 2292.3008482412856, 2374.3707917401903, 2378.143868207444, 2383.535210633927, 2286.0969916882905, 2293.2546922250253, 2304.043821813937, 2304.665823455606, 2310.6418505131733, 2308.1113771198043, 2310.5378924215224, 2315.8809689134423, 2317.2700599311165, 2320.756320586331, 8972.820543589092, 9049.592768325441, 9097.09029097085, 9102.271818254523, 9108.134727200906, 5053.140966035783, 5198.818041368534, 5200.609954253408, 5208.817691380784, 5208.895822083575, 3374.240795820945, 3414.453687410027, 3477.930441391158, 3478.6521347865264, 3479.3389256041273, 1070.6038765656679, 1078.0006177082953, 1083.2038451737967, 1086.5110700184869, 1089.4171618184234, 12482.188657737219, 12584.874151258553, 12595.811062834066, 12620.368981550977, 12625.873741262561, 4476.753778542212, 4730.62155027597, 4842.443119041285, 4854.732989685601, 4878.390201224847, 10545.736356590993, 10547.103496202755, 10548.208884333706, 10550.577976880839, 10559.63041293551, 5211.114110601131, 5218.191180367049, 5223.869403264873, 5226.869328266747, 5231.136862417735, 4629.213033784265, 4710.576048155683, 4825.420949486014, 4826.962203126344, 4829.830955916596, 3948.407738839197, 4027.476428064333, 4049.372347286175, 4097.221527909687, 4118.19695159441, 1197.8442802435627, 1238.052889539503, 1323.1597935311147, 1342.9798553021712, 1356.138851829076, 815.604431850552, 820.7045463633087, 829.0093338460482, 858.5106489301038, 870.7692461497708, 5324.787008519694, 5404.756785944642, 5427.158790387496, 5603.439656034364, 5667.4332566743, 897.6902968475865, 925.0703043441433, 939.6100618243489, 941.7127776028377, 946.2477330522252, 3628.2743451309843, 3688.8933320003894, 3749.2940711975984, 3750.6249375062275, 3831.865884694078, 10605.151587872951, 11135.721606959729, 11135.721606959729, 11139.554417823358, 11144.888551114385, 11002.33985960845, 11028.834567481494, 11050.226484146193, 11061.889381106086, 11079.169062320358, 7890.802729931683, 8078.474899131656, 8269.875951860728, 8303.6678532858, 8335.708250211213, 5633.577481688808, 5709.8287051388525, 5771.942280577308, 5805.187273781589, 5929.318128415288, 10045.799084018425, 10105.696829095139, 10117.59529618807, 10122.79754404893, 10185.9490702546, 10445.164386848883, 10467.476626168509, 10536.894631053592, 10582.0, 10673.786524269315, 7653.961730191313, 8032.959835201021, 8217.342612591097, 8220.63007164667, 8227.670893164206, 8471.407001509835, 8733.956330218309, 8816.294696424398, 8823.514706691194, 8835.0, 6977.441804655717, 7068.611226382598, 7114.537555058904, 7142.321479459443, 7372.778816635295, 7110.182329032227, 7118.572885626879, 7140.143182818095, 7180.066591343092, 7196.424286057208, 6662.733490660319, 6673.9332606673315, 6682.164729408824, 6717.731290748511, 6734.292899245509, 4651.976740116278, 4761.381020467317, 4816.831410900601, 4828.830990915301, 4856.635752318661, 4739.928901066418, 4842.975785121052, 4875.439324477588, 4953.578945789648, 5078.060558796635], "value": 4590.459832690182, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.713610614341, 321.8020917135961, 325.87779582656503, 326.83331500934526, 327.65268815056055, 4991.725455099968, 5143.5113664201845, 5189.481051894809, 5254.947450525494, 5315.920261196085, 4969.62727795415, 5084.186530155176, 5109.744512774365, 5137.460566640496, 5144.871378215546, 4072.552019277877, 4072.902455235556, 4082.3060079786505, 4083.3466645336753, 4093.8362465501345, 3975.2248311579256, 4074.675730387621, 4077.9184416311655, 4091.3044782387065, 4094.3653733671326, 4029.7783621900785, 4042.3734321180264, 4046.089629833293, 4057.431959525669, 4067.6339129478342, 4026.235015347104, 4042.2319759245797, 4043.130726893732, 4049.1699201663737, 4055.3916912463073, 3627.6009638939695, 3631.110377957391, 3632.872849450283, 3650.8904732858055, 3652.9634703653155, 4893.339399181101, 4996.925046124311, 5056.064628043787, 5077.923831142536, 5078.619103567247, 4576.290674945356, 4587.839425620087, 4594.19601569724, 4596.35651008859, 4615.907681846378, 5355.6251062425645, 5357.142857142878, 5370.221317908881, 5371.543418809406, 5375.838724838261, 3674.5590529136407, 3859.7684138951754, 3878.4596089561383, 3899.3622678474826, 3928.9803550982347, 5558.972205138989, 5558.972205138989, 5574.136008918665, 5593.804216852432, 5607.971960140173, 3976.304146774303, 4004.9199016019516, 4004.9787304237234, 4011.498562679665, 4014.41790940312, 3949.2101579683604, 3983.46223259862, 3991.1219531702977, 4059.086705491241, 4066.779966010185, 4553.840615578505, 4554.476235232924, 4557.977210113928, 4574.405327307429, 4595.862124136282, 5408.025585927724, 5410.08028635133, 5413.864653383618, 5435.483629055233, 5446.128619420873, 1321.5242512695422, 1334.219481603273, 1336.7660659384762, 1361.1900918953206, 1377.1530508737255, 927.2720914082548, 936.9250459963187, 959.8464245720651, 959.9088086631759, 977.130353984954, 5093.312402825572, 5128.487096306599, 5173.948260517422, 5184.0, 5196.68819870809, 5476.945230547643, 5478.616496845262, 5486.231927530069, 5487.64330318528, 5527.668339899538, 4962.330085438492, 5086.949130508721, 5128.615353848401, 5176.145935920531, 5192.273081768555, 2519.375003123012, 2532.961485790817, 2564.230730780758, 2574.4336246025846, 2590.857502837362, 4930.939847932712, 4939.357883475125, 4948.529889660548, 4954.727489988013, 4970.751462426864, 4662.184117779375, 4794.856154315376, 4889.779959901813, 4896.902061958741, 4917.827876024322, 4906.239532872411, 4949.688332591794, 4965.428975667773, 4967.286286231244, 4987.800487980513, 4818.614510839195, 4827.831025914076, 4836.226203807374, 4856.757162141949, 4864.878378040577, 4591.793369298322, 4718.787654555485, 4736.537000759655, 4765.309030190672, 4847.158079929745, 4969.701817890938, 5017.0, 5030.522100400456, 5039.395272567169, 5053.242013697828, 3657.0308868149427, 3663.7801731895106, 3682.3739964205615, 3688.3360995021153, 3689.4281386385155, 4743.264793956942, 4773.260144677581, 4877.756112194447, 4927.384076990376, 4942.4810394909455, 4666.366771629902, 4674.74288914113, 4713.787879545497, 4715.72675377653, 4736.692115012651, 4685.297205419214, 4694.507076756891, 4703.9529604704885, 4719.890825656037, 4744.481765835038, 4386.477775279291, 4660.6271498279375, 4695.812167513262, 4729.722974796717, 4744.4543877454535, 4590.6327493799745, 4735.408073990751, 4747.952520474751, 4752.477227505041, 4761.523847615211, 4629.629629629689, 4655.255159174516, 4670.743109129031, 4678.438587369537, 4726.8109275628585], "value": 3922.2572194834797, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.3168198162205, 573.9024365857804, 583.5885700581091, 598.1834795504138, 619.4270299972525, 12315.38423078847, 13082.869171308284, 13115.344232788359, 13130.671733206651, 13145.47418103276, 12538.122331436804, 13121.803172952414, 13231.669208269797, 13237.470501179965, 13239.470421183141, 646.3278190681685, 786.0606575142692, 807.5840941914919, 810.2586133687669, 811.1726039439768, 661.5534514202918, 783.165928286376, 786.7403756760284, 797.696875187428, 812.1350761439048, 852.7569642651846, 857.0786404615033, 860.2558786649535, 862.7411776467067, 863.6286396849353, 670.5607826873405, 854.478767951549, 855.6962278391175, 857.0829212742368, 857.6097875466647, 506.8023470846373, 589.6196952965356, 596.6211455725602, 601.308495230484, 612.0329878791499, 12765.170263932907, 12776.680582985407, 12812.871871281355, 13159.144655597356, 13167.078304518687, 12923.806142907864, 13450.86549134506, 13666.385012674453, 13690.657733556642, 13775.655608609764, 12034.458449369711, 12316.13787034908, 12317.630471085882, 12444.81332780009, 12690.492380304777, 4115.135821477494, 4142.896427589304, 4210.179015092058, 4218.894527636803, 4345.109252603209, 76647.61676191584, 77367.6131619344, 77792.61103694502, 80136.59931700304, 80590.19409805886, 11221.887781122085, 11236.831447528293, 11290.604828830952, 11418.885811141949, 11433.313171404714, 20322.18711251563, 20439.591208175752, 20442.0, 20471.0, 20536.0, 7723.0, 7798.727044553413, 7825.960870195727, 8037.799055023671, 8069.798255043671, 4101.364288535282, 4149.211649786531, 4177.895552611149, 4311.159323931866, 4408.823647054146, 2947.1747910585073, 3024.894128705485, 3034.620672415948, 3036.316828713566, 3051.5727798108283, 582.9708514574254, 589.9380565040694, 591.7425919724933, 594.313567829158, 599.0594766216998, 487.9853604391874, 548.7777450132703, 568.8606291458619, 581.8914966987895, 600.9519238460913, 7663.164629087162, 7961.761147165595, 8124.268815806606, 8209.302209312274, 8463.0, 522.3001178420934, 560.1010378342701, 587.2131343999062, 603.7886739641091, 622.9595076320115, 3818.255440189192, 3927.5483319418063, 4080.693947953856, 4085.080856807195, 4095.7952102395357, 69812.3018769816, 70378.0, 70585.64707176431, 98810.50594747125, 104010.0, 96888.0, 98337.50831245798, 103471.4826425863, 106095.46952265344, 107520.0, 56127.719361403746, 58100.70949645225, 58411.0, 91126.08873911308, 94619.52690236505, 7568.772936811904, 7705.113911899979, 7840.882386764317, 7854.096778870503, 7874.6850125994315, 53058.0, 53578.19632705435, 53689.19466208088, 54397.72801135969, 54450.727746361015, 70134.0, 71725.64137179281, 78496.0, 79739.60130199311, 80441.59779201067, 10966.506507207036, 11066.667999960015, 11076.5569377224, 11233.32600044, 11251.774964500828, 11246.212765106364, 11339.319640821577, 11373.601923932623, 11476.0, 11953.163278570417, 10616.203784716023, 10909.727081875248, 11087.113030957666, 11121.555137794398, 11250.156238282325, 10063.345882517613, 10446.582136714447, 10484.37492188712, 10745.875509481264, 10788.784224315626, 9776.0, 10206.336588121749, 10268.897311027093, 10608.416537090534, 10738.194635402533, 8527.573621318785, 9051.14014168653, 9075.410098343587, 9205.079492050741, 9270.306564095714, 8154.75535733929, 8336.416450848625, 8677.479351238946, 9029.458232506071, 9062.365634405529], "value": 6710.0159756985195, "unit": "score"}], "name": "dromaeo_css", "value": 6879.858095808314, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 112.0, 111.0, 110.0, 112.0, 110.0, 111.0, 111.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 131.0, 123.0, 173.0, 126.0, 124.0, 124.0, 127.0, 153.0, 124.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 162.0, 162.0, 161.0, 162.0, 161.0, 160.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 116.0, 77.0, 78.0, 88.0, 77.0, 98.0, 76.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 108.0, 83.0, 83.0, 83.0, 115.0, 83.0, 83.0, 109.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 51.0, 56.0, 52.0, 53.0, 52.0, 53.0, 51.0, 53.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 60.0, 61.0, 62.0, 61.0, 60.0, 61.0, 64.0, 62.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 89.0, 83.0, 80.0, 80.0, 80.0, 80.0, 78.0, 78.0, 80.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 129.0, 136.0, 136.0, 140.0, 131.0, 131.0, 132.0, 163.0, 133.0], "value": 136.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 165.0, 166.0, 167.0, 168.0, 169.0, 169.0, 172.0, 168.0, 166.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 66.0, 66.0, 66.0, 79.0, 67.0, 66.0, 66.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1508.2000000000003, "alertThreshold": 2.0}]} 01:34:35 INFO - Return code: 0 01:34:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:34:35 INFO - # TBPL SUCCESS # 01:34:35 INFO - Running post-action listener: _resource_record_post_action 01:34:35 INFO - [mozharness: 2016-10-04 08:34:35.697703Z] Finished run-tests step (success) 01:34:35 INFO - Running post-run listener: _resource_record_post_run 01:34:35 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 404140032; Read time: 8; Write time: 356492 01:34:35 INFO - TinderboxPrint: CPU usage
13.1% 01:34:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 01:34:35 INFO - TinderboxPrint: I/O write bytes / time
404,140,032 / 356,492 01:34:35 INFO - TinderboxPrint: CPU idle
8,301.1 (86.8%) 01:34:35 INFO - TinderboxPrint: CPU user
1,204.9 (12.6%) 01:34:35 INFO - TinderboxPrint: Swap in / out
0 / 0 01:34:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115609600; Read time: 0; Write time: 90992 01:34:35 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288530432; Read time: 0; Write time: 265500 01:34:36 INFO - Running post-run listener: _upload_blobber_files 01:34:36 INFO - Blob upload gear active. 01:34:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:34:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:34:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:34:36 INFO - (blobuploader) - INFO - Open directory for files ... 01:34:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:34:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:34:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:34:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:34:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:34:40 INFO - (blobuploader) - INFO - Done attempting. 01:34:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:34:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:34:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:34:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:34:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:34:41 INFO - (blobuploader) - INFO - Done attempting. 01:34:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:34:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:34:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:34:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:34:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:34:41 INFO - (blobuploader) - INFO - Done attempting. 01:34:41 INFO - (blobuploader) - INFO - Iteration through files over. 01:34:41 INFO - Return code: 0 01:34:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:34:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:34:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49ee7e96f6bcf7b350740e7cc2068dfdb237684bc1b316e4f976276fe1123cf0903fc4dce1603133a3e74eae73c69a3a6e864c46eec22e981e2604cda6f37d5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1822cc3765ecc724c82bd0306bec259b32bf827175f3ab735dea6db6cb2f1db84ea231cf0e30d628a78e58826e2b51ab8c585b7f0e3c5c5daf728a05e9a7956e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f4cad07f76aeeb9146017ddfbdc0cd5e454a4ad26a9967f1f5e5a84dafc49bbeac72894d6eb69a15231634de248331d6d69ff95971b74b33dc7ef61bcb92944"} 01:34:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:34:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:34:41 INFO - Contents: 01:34:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49ee7e96f6bcf7b350740e7cc2068dfdb237684bc1b316e4f976276fe1123cf0903fc4dce1603133a3e74eae73c69a3a6e864c46eec22e981e2604cda6f37d5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1822cc3765ecc724c82bd0306bec259b32bf827175f3ab735dea6db6cb2f1db84ea231cf0e30d628a78e58826e2b51ab8c585b7f0e3c5c5daf728a05e9a7956e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f4cad07f76aeeb9146017ddfbdc0cd5e454a4ad26a9967f1f5e5a84dafc49bbeac72894d6eb69a15231634de248331d6d69ff95971b74b33dc7ef61bcb92944"} 01:34:41 INFO - Running post-run listener: copy_logs_to_upload_dir 01:34:41 INFO - Copying logs to upload dir... 01:34:41 INFO - mkdir: /builds/slave/test/build/upload/logs 01:34:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.077734 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-04 01:34:41.235457) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 01:34:41.240112) ========= 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=af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49ee7e96f6bcf7b350740e7cc2068dfdb237684bc1b316e4f976276fe1123cf0903fc4dce1603133a3e74eae73c69a3a6e864c46eec22e981e2604cda6f37d5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1822cc3765ecc724c82bd0306bec259b32bf827175f3ab735dea6db6cb2f1db84ea231cf0e30d628a78e58826e2b51ab8c585b7f0e3c5c5daf728a05e9a7956e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f4cad07f76aeeb9146017ddfbdc0cd5e454a4ad26a9967f1f5e5a84dafc49bbeac72894d6eb69a15231634de248331d6d69ff95971b74b33dc7ef61bcb92944"} build_url:https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011361 build_url: 'https://queue.taskcluster.net/v1/task/LpTKWDYJT3y798gRww3WGA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49ee7e96f6bcf7b350740e7cc2068dfdb237684bc1b316e4f976276fe1123cf0903fc4dce1603133a3e74eae73c69a3a6e864c46eec22e981e2604cda6f37d5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1822cc3765ecc724c82bd0306bec259b32bf827175f3ab735dea6db6cb2f1db84ea231cf0e30d628a78e58826e2b51ab8c585b7f0e3c5c5daf728a05e9a7956e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f4cad07f76aeeb9146017ddfbdc0cd5e454a4ad26a9967f1f5e5a84dafc49bbeac72894d6eb69a15231634de248331d6d69ff95971b74b33dc7ef61bcb92944"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 01:34:41.270910) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 01:34:41.271322) ========= 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=af724c981e2a0f424dbabf99000001e7-1475568051.886832-8322382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 01:34:41.355183) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 01:34:41.355509) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 01:34:41.355844) ========= ========= Total master_lag: 0.18 =========