builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1478630954.86 results: success (0) buildid: 20161108030212 builduid: 5f4e42c5c6fb4ba2822ef60cdb11a2b3 revision: f13e90d496cf1bc6dfc4fd398da33e4afe785bde ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 10:49:14.860995) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 10:49:14.861657) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 10:49:14.861962) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 10:49:14.876830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 10:49:14.877118) ========= 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=6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-08 10:49:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.0M=0s 2016-11-08 10:49:15 (42.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139189 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 10:49:15.030415) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 10:49:15.030783) ========= 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=6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014239 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 10:49:15.080666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 10:49:15.081016) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f13e90d496cf1bc6dfc4fd398da33e4afe785bde --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 f13e90d496cf1bc6dfc4fd398da33e4afe785bde --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=6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-08 10:49:15,465 truncating revision to first 12 chars 2016-11-08 10:49:15,465 Setting DEBUG logging. 2016-11-08 10:49:15,465 attempt 1/10 2016-11-08 10:49:15,465 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f13e90d496cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-08 10:49:15,782 unpacking tar archive at: mozilla-central-f13e90d496cf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.647257 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 10:49:15.741965) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 10:49:15.742310) ========= script_repo_revision: f13e90d496cf1bc6dfc4fd398da33e4afe785bde ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 10:49:15.742768) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 10:49:15.743072) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 10:49:15.752206) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-11-08 10:49:15.752520) ========= /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=6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:49:16 INFO - MultiFileLogger online at 20161108 10:49:16 in /builds/slave/test 10:49:16 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 10:49:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:49:16 INFO - {'append_to_log': False, 10:49:16 INFO - 'base_work_dir': '/builds/slave/test', 10:49:16 INFO - 'blob_upload_branch': 'Firefox', 10:49:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:49:16 INFO - 'branch': 'Firefox', 10:49:16 INFO - 'buildbot_json_path': 'buildprops.json', 10:49:16 INFO - 'config_files': ('talos/linux_config.py',), 10:49:16 INFO - 'default_actions': ('clobber', 10:49:16 INFO - 'read-buildbot-config', 10:49:16 INFO - 'download-and-extract', 10:49:16 INFO - 'populate-webroot', 10:49:16 INFO - 'create-virtualenv', 10:49:16 INFO - 'install', 10:49:16 INFO - 'run-tests'), 10:49:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:49:16 INFO - 'download_minidump_stackwalk': True, 10:49:16 INFO - 'download_symbols': 'ondemand', 10:49:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:49:16 INFO - 'tooltool.py': '/tools/tooltool.py', 10:49:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:49:16 INFO - '/tools/misc-python/virtualenv.py')}, 10:49:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:49:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:49:16 INFO - 'installer_path': 'installer.exe', 10:49:16 INFO - 'log_level': 'info', 10:49:16 INFO - 'log_name': 'talos', 10:49:16 INFO - 'log_to_console': True, 10:49:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:49:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:49:16 INFO - 'opt_config_files': (), 10:49:16 INFO - 'pip_index': False, 10:49:16 INFO - 'sps_profile': False, 10:49:16 INFO - 'sps_profile_interval': 0, 10:49:16 INFO - 'suite': 'dromaeojs', 10:49:16 INFO - 'system_bits': '32', 10:49:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:49:16 INFO - 'title': 'talos-linux64-ix-050', 10:49:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:49:16 INFO - 'use_talos_json': True, 10:49:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:49:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:49:16 INFO - 'work_dir': 'build'} 10:49:16 INFO - [mozharness: 2016-11-08 18:49:16.238734Z] Running clobber step. 10:49:16 INFO - Running pre-action listener: _resource_record_pre_action 10:49:16 INFO - Running main action method: clobber 10:49:16 INFO - rmtree: /builds/slave/test/build 10:49:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:49:16 INFO - Running post-action listener: _resource_record_post_action 10:49:16 INFO - [mozharness: 2016-11-08 18:49:16.704571Z] Finished clobber step (success) 10:49:16 INFO - [mozharness: 2016-11-08 18:49:16.704671Z] Running read-buildbot-config step. 10:49:16 INFO - Running pre-action listener: _resource_record_pre_action 10:49:16 INFO - Running main action method: read_buildbot_config 10:49:16 INFO - Using buildbot properties: 10:49:16 INFO - { 10:49:16 INFO - "project": "", 10:49:16 INFO - "product": "firefox", 10:49:16 INFO - "script_repo_revision": "production", 10:49:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:49:16 INFO - "repository": "", 10:49:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:49:16 INFO - "buildid": "20161108030212", 10:49:16 INFO - "stage_platform": "linux64-pgo", 10:49:16 INFO - "basedir": "/builds/slave/test", 10:49:16 INFO - "nightly_build": "True", 10:49:16 INFO - "buildnumber": 57, 10:49:16 INFO - "slavename": "talos-linux64-ix-050", 10:49:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:49:16 INFO - "platform": "ubuntu64_hw", 10:49:16 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:49:16 INFO - "branch": "mozilla-central", 10:49:16 INFO - "repo_path": "mozilla-central", 10:49:16 INFO - "revision": "f13e90d496cf1bc6dfc4fd398da33e4afe785bde", 10:49:16 INFO - "pgo_build": "True", 10:49:16 INFO - "builduid": "5f4e42c5c6fb4ba2822ef60cdb11a2b3", 10:49:16 INFO - "slavebuilddir": "test" 10:49:16 INFO - } 10:49:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/EXLkjXmsRla-x_6RtV3kpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:49:16 INFO - Running post-action listener: _resource_record_post_action 10:49:16 INFO - [mozharness: 2016-11-08 18:49:16.707208Z] Finished read-buildbot-config step (success) 10:49:16 INFO - [mozharness: 2016-11-08 18:49:16.707297Z] Running download-and-extract step. 10:49:16 INFO - Running pre-action listener: _resource_record_pre_action 10:49:16 INFO - Running main action method: download_and_extract 10:49:16 INFO - mkdir: /builds/slave/test/build/tests 10:49:16 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')]} 10:49:16 INFO - trying https://queue.taskcluster.net/v1/task/EXLkjXmsRla-x_6RtV3kpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:49:16 INFO - Downloading https://queue.taskcluster.net/v1/task/EXLkjXmsRla-x_6RtV3kpw/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 10:49:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EXLkjXmsRla-x_6RtV3kpw/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 10:49:17 INFO - Downloaded 1361 bytes. 10:49:17 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:49:17 INFO - Using the following test package requirements: 10:49:17 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:49:17 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:49:17 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:49:17 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:17 INFO - u'jsshell-linux-x86_64.zip'], 10:49:17 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:49:17 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:49:17 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:49:17 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:49:17 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:49:17 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:49:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:49:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EXLkjXmsRla-x_6RtV3kpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:49:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EXLkjXmsRla-x_6RtV3kpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:49:17 INFO - Fetch https://queue.taskcluster.net/v1/task/EXLkjXmsRla-x_6RtV3kpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:49:17 INFO - Http code: 200 10:49:17 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 10:49:17 INFO - x-amz-cf-id: g-qDb0dJ3eAUggMKIA-ehU2B_lnUA_C0kbuXLTcOPuE3uTNCIgaHVw== 10:49:17 INFO - x-amz-version-id: ui6mgaM5BheWWRT0fK8IgNgVstxDt1e. 10:49:18 INFO - Expected file size: 21923005 10:49:18 INFO - Obtained file size: 21923005 10:49:22 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 10:49:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EXLkjXmsRla-x_6RtV3kpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:49:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EXLkjXmsRla-x_6RtV3kpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:49:22 INFO - Fetch https://queue.taskcluster.net/v1/task/EXLkjXmsRla-x_6RtV3kpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:49:22 INFO - Http code: 200 10:49:22 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 10:49:22 INFO - x-amz-cf-id: 6H0gyieaXTFNl6ntERbPMEAWIsXlYTaDJ5tH-BVKJPGdCvXuSRgOZQ== 10:49:22 INFO - x-amz-version-id: ui6mgaM5BheWWRT0fK8IgNgVstxDt1e. 10:49:22 INFO - Expected file size: 21923005 10:49:22 INFO - Obtained file size: 21923005 10:49:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EXLkjXmsRla-x_6RtV3kpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:49:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EXLkjXmsRla-x_6RtV3kpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:49:27 INFO - Fetch https://queue.taskcluster.net/v1/task/EXLkjXmsRla-x_6RtV3kpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:49:27 INFO - Http code: 200 10:49:27 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 10:49:27 INFO - x-amz-cf-id: 7rj7RsRm_VvEyQ692DNrVM71m4LyG2MXi3lm91XE7gJObSV3D0pPxA== 10:49:27 INFO - x-amz-version-id: L.iixryPSyFqZ9DWrK56jZQPMKvWuKtX 10:49:28 INFO - Expected file size: 14409038 10:49:28 INFO - Obtained file size: 14409038 10:49:28 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')]} 10:49:28 INFO - trying https://queue.taskcluster.net/v1/task/EXLkjXmsRla-x_6RtV3kpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:49:28 INFO - Downloading https://queue.taskcluster.net/v1/task/EXLkjXmsRla-x_6RtV3kpw/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 10:49:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EXLkjXmsRla-x_6RtV3kpw/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 10:49:29 INFO - Downloaded 59662571 bytes. 10:49:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EXLkjXmsRla-x_6RtV3kpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:49:29 INFO - mkdir: /builds/slave/test/properties 10:49:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:49:29 INFO - Writing to file /builds/slave/test/properties/build_url 10:49:29 INFO - Contents: 10:49:29 INFO - build_url:https://queue.taskcluster.net/v1/task/EXLkjXmsRla-x_6RtV3kpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:49:30 INFO - Running post-action listener: _resource_record_post_action 10:49:30 INFO - Running post-action listener: set_extra_try_arguments 10:49:30 INFO - [mozharness: 2016-11-08 18:49:30.409575Z] Finished download-and-extract step (success) 10:49:30 INFO - [mozharness: 2016-11-08 18:49:30.409873Z] Running populate-webroot step. 10:49:30 INFO - Running pre-action listener: _resource_record_pre_action 10:49:30 INFO - Running main action method: populate_webroot 10:49:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:49:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:49:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:49:30 INFO - '--tppagecycles', 10:49:30 INFO - '7'], 10:49:30 INFO - 'tests': ['tsvgm']}}, 10:49:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:49:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:49:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:49:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:49:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:49:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:49:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:30 INFO - 'talos_options': ['--disable-e10s'], 10:49:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:49:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:49:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:30 INFO - 'talos_options': ['--disable-e10s'], 10:49:30 INFO - 'tests': ['damp', 'tps']}, 10:49:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:30 INFO - 'tests': ['damp', 'tps']}, 10:49:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:49:30 INFO - 'tests': ['dromaeo_dom']}, 10:49:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:49:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:49:30 INFO - 'tests': ['basic_compositor_video']}, 10:49:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:49:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:49:30 INFO - 'tests': ['a11yr', 10:49:30 INFO - 'ts_paint', 10:49:30 INFO - 'tpaint', 10:49:30 INFO - 'sessionrestore', 10:49:30 INFO - 'sessionrestore_no_auto_restore', 10:49:30 INFO - 'tabpaint']}, 10:49:30 INFO - 'other-e10s': {'tests': ['a11yr', 10:49:30 INFO - 'ts_paint', 10:49:30 INFO - 'tpaint', 10:49:30 INFO - 'sessionrestore', 10:49:30 INFO - 'sessionrestore_no_auto_restore', 10:49:30 INFO - 'tabpaint']}, 10:49:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:49:30 INFO - 'ts_paint', 10:49:30 INFO - 'tpaint', 10:49:30 INFO - 'sessionrestore', 10:49:30 INFO - 'sessionrestore_no_auto_restore', 10:49:30 INFO - 'tabpaint']}, 10:49:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:49:30 INFO - 'ts_paint', 10:49:30 INFO - 'tpaint', 10:49:30 INFO - 'sessionrestore', 10:49:30 INFO - 'sessionrestore_no_auto_restore', 10:49:30 INFO - 'tabpaint']}, 10:49:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:49:30 INFO - 'tests': ['a11yr', 10:49:30 INFO - 'ts_paint', 10:49:30 INFO - 'tpaint', 10:49:30 INFO - 'sessionrestore', 10:49:30 INFO - 'sessionrestore_no_auto_restore', 10:49:30 INFO - 'tabpaint']}, 10:49:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:49:30 INFO - 'tests': ['a11yr', 10:49:30 INFO - 'ts_paint', 10:49:30 INFO - 'tpaint', 10:49:30 INFO - 'sessionrestore', 10:49:30 INFO - 'sessionrestore_no_auto_restore', 10:49:30 INFO - 'tabpaint']}, 10:49:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:49:30 INFO - 'tests': ['tsvgx', 10:49:30 INFO - 'tsvgr_opacity', 10:49:30 INFO - 'tart', 10:49:30 INFO - 'tscrollx', 10:49:30 INFO - 'cart']}, 10:49:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:49:30 INFO - 'tsvgr_opacity', 10:49:30 INFO - 'tart', 10:49:30 INFO - 'tscrollx', 10:49:30 INFO - 'cart']}, 10:49:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:30 INFO - 'talos_options': ['--disable-e10s'], 10:49:30 INFO - 'tests': ['tp5o']}, 10:49:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:30 INFO - 'tests': ['tp5o']}, 10:49:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:30 INFO - 'talos_options': ['--disable-e10s', 10:49:30 INFO - '--xperf_path', 10:49:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:49:30 INFO - 'tests': ['tp5n']}, 10:49:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:30 INFO - 'talos_options': ['--xperf_path', 10:49:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:49:30 INFO - 'tests': ['tp5n']}}, 10:49:30 INFO - 'talos.zip': {'path': '', 10:49:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:49:30 INFO - Running post-action listener: _resource_record_post_action 10:49:30 INFO - [mozharness: 2016-11-08 18:49:30.430876Z] Finished populate-webroot step (success) 10:49:30 INFO - [mozharness: 2016-11-08 18:49:30.430968Z] Running create-virtualenv step. 10:49:30 INFO - Running pre-action listener: _resource_record_pre_action 10:49:30 INFO - Running main action method: create_virtualenv 10:49:30 INFO - Creating virtualenv /builds/slave/test/build/venv 10:49:30 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 10:49:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:49:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:49:30 INFO - Using real prefix '/usr' 10:49:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:49:31 INFO - Installing distribute.............................................................................................................................................................................................done. 10:49:32 INFO - Installing pip.................done. 10:49:33 INFO - Return code: 0 10:49:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:49:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:49:33 INFO - Reading from file tmpfile_stdout 10:49:33 INFO - Output received: 10:49:33 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) 10:49:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:49: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')]} 10:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49: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')]} 10:49:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:33 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 0x7f46cce1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c930>, '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 0x1f3d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3dcc0>, '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': '6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618', '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 10:49:33 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 10:49:33 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 10:49:33 INFO - Using env: {'DISPLAY': ':0', 10:49:33 INFO - 'HOME': '/home/cltbld', 10:49:33 INFO - 'LANG': 'en_US.UTF-8', 10:49:33 INFO - 'LANGUAGE': 'en_US:en', 10:49:33 INFO - 'LOGNAME': 'cltbld', 10:49:33 INFO - 'MAIL': '/var/mail/cltbld', 10:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:33 INFO - 'MOZ_NO_REMOTE': '1', 10:49:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:33 INFO - 'NO_EM_RESTART': '1', 10:49:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:33 INFO - 'PWD': '/builds/slave/test', 10:49:33 INFO - 'SHELL': '/bin/bash', 10:49:33 INFO - 'SHLVL': '1', 10:49:33 INFO - 'TERM': 'linux', 10:49:33 INFO - 'TMOUT': '86400', 10:49:33 INFO - 'USER': 'cltbld', 10:49:33 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618', 10:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:33 INFO - '_': '/tools/buildbot/bin/python'} 10:49:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:33 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 10:49:33 INFO - Cleaning up... 10:49:33 INFO - Return code: 0 10:49:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:49: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')]} 10:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49: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')]} 10:49:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:33 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 0x7f46cce1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c930>, '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 0x1f3d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3dcc0>, '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': '6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618', '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 10:49:33 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 10:49:33 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 10:49:33 INFO - Using env: {'DISPLAY': ':0', 10:49:33 INFO - 'HOME': '/home/cltbld', 10:49:33 INFO - 'LANG': 'en_US.UTF-8', 10:49:33 INFO - 'LANGUAGE': 'en_US:en', 10:49:33 INFO - 'LOGNAME': 'cltbld', 10:49:33 INFO - 'MAIL': '/var/mail/cltbld', 10:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:33 INFO - 'MOZ_NO_REMOTE': '1', 10:49:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:33 INFO - 'NO_EM_RESTART': '1', 10:49:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:33 INFO - 'PWD': '/builds/slave/test', 10:49:33 INFO - 'SHELL': '/bin/bash', 10:49:33 INFO - 'SHLVL': '1', 10:49:33 INFO - 'TERM': 'linux', 10:49:33 INFO - 'TMOUT': '86400', 10:49:33 INFO - 'USER': 'cltbld', 10:49:33 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618', 10:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:33 INFO - '_': '/tools/buildbot/bin/python'} 10:49:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:33 INFO - Downloading/unpacking psutil>=3.1.1 10:49:33 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 10:49:33 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 10:49:33 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 10:49:33 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 10:49:33 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 10:49:33 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 10:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:49:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:49:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:49:35 INFO - Installing collected packages: psutil 10:49:35 INFO - Running setup.py install for psutil 10:49:35 INFO - building 'psutil._psutil_linux' extension 10:49:35 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 10:49:35 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 10:49:35 INFO - building 'psutil._psutil_posix' extension 10:49:35 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 10:49:36 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 10:49:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:49:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:49:36 INFO - Successfully installed psutil 10:49:36 INFO - Cleaning up... 10:49:36 INFO - Return code: 0 10:49:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:49: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')]} 10:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49: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')]} 10:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:36 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 0x7f46cce1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c930>, '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 0x1f3d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3dcc0>, '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': '6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618', '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 10:49:36 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 10:49:36 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 10:49:36 INFO - Using env: {'DISPLAY': ':0', 10:49:36 INFO - 'HOME': '/home/cltbld', 10:49:36 INFO - 'LANG': 'en_US.UTF-8', 10:49:36 INFO - 'LANGUAGE': 'en_US:en', 10:49:36 INFO - 'LOGNAME': 'cltbld', 10:49:36 INFO - 'MAIL': '/var/mail/cltbld', 10:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:36 INFO - 'MOZ_NO_REMOTE': '1', 10:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:36 INFO - 'NO_EM_RESTART': '1', 10:49:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:36 INFO - 'PWD': '/builds/slave/test', 10:49:36 INFO - 'SHELL': '/bin/bash', 10:49:36 INFO - 'SHLVL': '1', 10:49:36 INFO - 'TERM': 'linux', 10:49:36 INFO - 'TMOUT': '86400', 10:49:36 INFO - 'USER': 'cltbld', 10:49:36 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618', 10:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:36 INFO - '_': '/tools/buildbot/bin/python'} 10:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:49:36 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 10:49:36 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 10:49:36 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 10:49:36 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 10:49:36 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 10:49:36 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 10:49:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:49:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:49:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:49:38 INFO - Installing collected packages: mozsystemmonitor 10:49:38 INFO - Running setup.py install for mozsystemmonitor 10:49:38 INFO - Successfully installed mozsystemmonitor 10:49:38 INFO - Cleaning up... 10:49:38 INFO - Return code: 0 10:49:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f46cce1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c930>, '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 0x1f3d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3dcc0>, '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': '6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618', '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 10:49:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:49:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:49:38 INFO - Using env: {'DISPLAY': ':0', 10:49:38 INFO - 'HOME': '/home/cltbld', 10:49:38 INFO - 'LANG': 'en_US.UTF-8', 10:49:38 INFO - 'LANGUAGE': 'en_US:en', 10:49:38 INFO - 'LOGNAME': 'cltbld', 10:49:38 INFO - 'MAIL': '/var/mail/cltbld', 10:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:38 INFO - 'MOZ_NO_REMOTE': '1', 10:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:38 INFO - 'NO_EM_RESTART': '1', 10:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:38 INFO - 'PWD': '/builds/slave/test', 10:49:38 INFO - 'SHELL': '/bin/bash', 10:49:38 INFO - 'SHLVL': '1', 10:49:38 INFO - 'TERM': 'linux', 10:49:38 INFO - 'TMOUT': '86400', 10:49:38 INFO - 'USER': 'cltbld', 10:49:38 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618', 10:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:38 INFO - '_': '/tools/buildbot/bin/python'} 10:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:38 INFO - Downloading/unpacking jsonschema==2.5.1 10:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:49:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:40 INFO - Downloading functools32-3.2.3-2.tar.gz 10:49:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:49:41 INFO - warning: no files found matching '*.txt' 10:49:41 INFO - no previously-included directories found matching 'build' 10:49:41 INFO - no previously-included directories found matching 'dist' 10:49:41 INFO - no previously-included directories found matching '.git*' 10:49:41 INFO - Installing collected packages: jsonschema, functools32 10:49:41 INFO - Running setup.py install for functools32 10:49:41 INFO - warning: no files found matching '*.txt' 10:49:41 INFO - no previously-included directories found matching 'build' 10:49:41 INFO - no previously-included directories found matching 'dist' 10:49:41 INFO - no previously-included directories found matching '.git*' 10:49:41 INFO - Successfully installed jsonschema functools32 10:49:41 INFO - Cleaning up... 10:49:41 INFO - Return code: 0 10:49:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:49:41 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')]} 10:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:41 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')]} 10:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:41 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 0x7f46cce1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c930>, '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 0x1f3d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3dcc0>, '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': '6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618', '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 10:49:41 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 10:49:41 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 10:49:41 INFO - Using env: {'DISPLAY': ':0', 10:49:41 INFO - 'HOME': '/home/cltbld', 10:49:41 INFO - 'LANG': 'en_US.UTF-8', 10:49:41 INFO - 'LANGUAGE': 'en_US:en', 10:49:41 INFO - 'LOGNAME': 'cltbld', 10:49:41 INFO - 'MAIL': '/var/mail/cltbld', 10:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:41 INFO - 'MOZ_NO_REMOTE': '1', 10:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:41 INFO - 'NO_EM_RESTART': '1', 10:49:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:41 INFO - 'PWD': '/builds/slave/test', 10:49:41 INFO - 'SHELL': '/bin/bash', 10:49:41 INFO - 'SHLVL': '1', 10:49:41 INFO - 'TERM': 'linux', 10:49:41 INFO - 'TMOUT': '86400', 10:49:41 INFO - 'USER': 'cltbld', 10:49:41 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618', 10:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:41 INFO - '_': '/tools/buildbot/bin/python'} 10:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:49:41 INFO - Cleaning up... 10:49:41 INFO - Return code: 0 10:49:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:49:41 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')]} 10:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:41 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')]} 10:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:41 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 0x7f46cce1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c930>, '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 0x1f3d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3dcc0>, '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': '6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618', '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 10:49:41 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 10:49:41 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 10:49:41 INFO - Using env: {'DISPLAY': ':0', 10:49:41 INFO - 'HOME': '/home/cltbld', 10:49:41 INFO - 'LANG': 'en_US.UTF-8', 10:49:41 INFO - 'LANGUAGE': 'en_US:en', 10:49:41 INFO - 'LOGNAME': 'cltbld', 10:49:41 INFO - 'MAIL': '/var/mail/cltbld', 10:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:41 INFO - 'MOZ_NO_REMOTE': '1', 10:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:41 INFO - 'NO_EM_RESTART': '1', 10:49:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:41 INFO - 'PWD': '/builds/slave/test', 10:49:41 INFO - 'SHELL': '/bin/bash', 10:49:41 INFO - 'SHLVL': '1', 10:49:41 INFO - 'TERM': 'linux', 10:49:41 INFO - 'TMOUT': '86400', 10:49:41 INFO - 'USER': 'cltbld', 10:49:41 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618', 10:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:41 INFO - '_': '/tools/buildbot/bin/python'} 10:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:41 INFO - Downloading/unpacking blobuploader==1.2.4 10:49:41 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 10:49:41 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 10:49:41 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 10:49:41 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 10:49:41 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 10:49:41 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 10:49:43 INFO - Downloading blobuploader-1.2.4.tar.gz 10:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:49:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:49:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:49:44 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 10:49:44 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 10:49:44 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 10:49:44 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 10:49:44 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 10:49:44 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 10:49:44 INFO - Downloading docopt-0.6.1.tar.gz 10:49:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:49:44 INFO - Installing collected packages: blobuploader, requests, docopt 10:49:44 INFO - Running setup.py install for blobuploader 10:49:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:49:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:49:44 INFO - Running setup.py install for requests 10:49:44 INFO - Running setup.py install for docopt 10:49:44 INFO - Successfully installed blobuploader requests docopt 10:49:44 INFO - Cleaning up... 10:49:44 INFO - Return code: 0 10:49:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:49:44 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')]} 10:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:44 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')]} 10:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:44 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 0x7f46cce1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c930>, '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 0x1f3d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3dcc0>, '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': '6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618', '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 10:49:44 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 10:49:44 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 10:49:44 INFO - Using env: {'DISPLAY': ':0', 10:49:44 INFO - 'HOME': '/home/cltbld', 10:49:44 INFO - 'LANG': 'en_US.UTF-8', 10:49:44 INFO - 'LANGUAGE': 'en_US:en', 10:49:44 INFO - 'LOGNAME': 'cltbld', 10:49:44 INFO - 'MAIL': '/var/mail/cltbld', 10:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:44 INFO - 'MOZ_NO_REMOTE': '1', 10:49:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:44 INFO - 'NO_EM_RESTART': '1', 10:49:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:44 INFO - 'PWD': '/builds/slave/test', 10:49:44 INFO - 'SHELL': '/bin/bash', 10:49:44 INFO - 'SHLVL': '1', 10:49:44 INFO - 'TERM': 'linux', 10:49:44 INFO - 'TMOUT': '86400', 10:49:44 INFO - 'USER': 'cltbld', 10:49:44 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618', 10:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:44 INFO - '_': '/tools/buildbot/bin/python'} 10:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:49:45 INFO - Running setup.py (path:/tmp/pip-_s2TQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:49:45 INFO - Running setup.py (path:/tmp/pip-m7jIJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:49:45 INFO - Running setup.py (path:/tmp/pip-i9eGfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:49:45 INFO - Running setup.py (path:/tmp/pip-O4MqoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:49:45 INFO - Running setup.py (path:/tmp/pip-Q8_pnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:49:45 INFO - Running setup.py (path:/tmp/pip-9gW_ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:49:45 INFO - Running setup.py (path:/tmp/pip-99PY6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:49:45 INFO - Running setup.py (path:/tmp/pip-gNZ7BG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:49:45 INFO - Running setup.py (path:/tmp/pip-fAMgS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:49:45 INFO - Running setup.py (path:/tmp/pip-jNCwj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:49:45 INFO - Running setup.py (path:/tmp/pip-SCMxyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:49:45 INFO - Running setup.py (path:/tmp/pip-6ZXVYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:49:46 INFO - Running setup.py (path:/tmp/pip-8MjNdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:49:46 INFO - Running setup.py (path:/tmp/pip-heITap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:49:46 INFO - Running setup.py (path:/tmp/pip-_vRs4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:49:46 INFO - Running setup.py (path:/tmp/pip-0GvXvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:49:46 INFO - Running setup.py (path:/tmp/pip-WfZJgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:49:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:49:46 INFO - Running setup.py install for manifestparser 10:49:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:49:46 INFO - Running setup.py install for mozcrash 10:49:46 INFO - Running setup.py install for mozdebug 10:49:46 INFO - Running setup.py install for mozdevice 10:49:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:49:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:49:46 INFO - Running setup.py install for mozfile 10:49:46 INFO - Running setup.py install for mozhttpd 10:49:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:49:47 INFO - Running setup.py install for mozinfo 10:49:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:49:47 INFO - Running setup.py install for mozInstall 10:49:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:49:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:49:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:49:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:49:47 INFO - Running setup.py install for mozleak 10:49:47 INFO - Running setup.py install for mozlog 10:49:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:49:47 INFO - Running setup.py install for moznetwork 10:49:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:49:47 INFO - Running setup.py install for mozprocess 10:49:47 INFO - Running setup.py install for mozprofile 10:49:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:49:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:49:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:49:47 INFO - Running setup.py install for mozrunner 10:49:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:49:47 INFO - Running setup.py install for mozscreenshot 10:49:48 INFO - Running setup.py install for moztest 10:49:48 INFO - Running setup.py install for mozversion 10:49:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:49:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:49:48 INFO - Cleaning up... 10:49:48 INFO - Return code: 0 10:49:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:49:48 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')]} 10:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:48 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')]} 10:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:48 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 0x7f46cce1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c930>, '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 0x1f3d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3dcc0>, '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': '6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618', '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 10:49:48 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 10:49:48 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 10:49:48 INFO - Using env: {'DISPLAY': ':0', 10:49:48 INFO - 'HOME': '/home/cltbld', 10:49:48 INFO - 'LANG': 'en_US.UTF-8', 10:49:48 INFO - 'LANGUAGE': 'en_US:en', 10:49:48 INFO - 'LOGNAME': 'cltbld', 10:49:48 INFO - 'MAIL': '/var/mail/cltbld', 10:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:48 INFO - 'MOZ_NO_REMOTE': '1', 10:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:48 INFO - 'NO_EM_RESTART': '1', 10:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:48 INFO - 'PWD': '/builds/slave/test', 10:49:48 INFO - 'SHELL': '/bin/bash', 10:49:48 INFO - 'SHLVL': '1', 10:49:48 INFO - 'TERM': 'linux', 10:49:48 INFO - 'TMOUT': '86400', 10:49:48 INFO - 'USER': 'cltbld', 10:49:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618', 10:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:48 INFO - '_': '/tools/buildbot/bin/python'} 10:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:49:48 INFO - Running setup.py (path:/tmp/pip-YerzrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:49:48 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)) 10:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:49:48 INFO - Running setup.py (path:/tmp/pip-vfcD2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:49:48 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)) 10:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:49:48 INFO - Running setup.py (path:/tmp/pip-BwkCBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:49:48 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)) 10:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:49:48 INFO - Running setup.py (path:/tmp/pip-KYoYmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:49:48 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)) 10:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:49:48 INFO - Running setup.py (path:/tmp/pip-dnYjSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:49:48 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)) 10:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:49:48 INFO - Running setup.py (path:/tmp/pip-5zM5jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:49:48 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)) 10:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:49:48 INFO - Running setup.py (path:/tmp/pip-M_paPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:49:48 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)) 10:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:49:48 INFO - Running setup.py (path:/tmp/pip-tNMqi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:49:49 INFO - Running setup.py (path:/tmp/pip-a54d1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:49:49 INFO - Running setup.py (path:/tmp/pip-I9eiZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:49:49 INFO - Running setup.py (path:/tmp/pip-3_iAlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:49:49 INFO - Running setup.py (path:/tmp/pip-RUWXD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:49:49 INFO - Running setup.py (path:/tmp/pip-jZfWP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:49:49 INFO - Running setup.py (path:/tmp/pip-wYXXN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:49:49 INFO - Running setup.py (path:/tmp/pip-vKNzH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:49:49 INFO - Running setup.py (path:/tmp/pip-tKsuTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:49:49 INFO - Running setup.py (path:/tmp/pip-ZftMAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:49:49 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)) 10:49:49 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)) 10:49:49 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)) 10:49:49 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)) 10:49:49 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)) 10:49:49 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)) 10:49:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:49:49 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 10:49:49 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 10:49:49 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 10:49:49 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 10:49:49 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 10:49:49 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 10:49:51 INFO - Downloading blessings-1.6.tar.gz 10:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:49:51 INFO - Installing collected packages: blessings 10:49:51 INFO - Running setup.py install for blessings 10:49:51 INFO - Successfully installed blessings 10:49:51 INFO - Cleaning up... 10:49:51 INFO - Return code: 0 10:49:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:49:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:49:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:49:52 INFO - Reading from file tmpfile_stdout 10:49:52 INFO - Current package versions: 10:49:52 INFO - argparse == 1.2.1 10:49:52 INFO - blessings == 1.6 10:49:52 INFO - blobuploader == 1.2.4 10:49:52 INFO - docopt == 0.6.1 10:49:52 INFO - functools32 == 3.2.3-2 10:49:52 INFO - jsonschema == 2.5.1 10:49:52 INFO - manifestparser == 1.1 10:49:52 INFO - mozInstall == 1.12 10:49:52 INFO - mozcrash == 0.17 10:49:52 INFO - mozdebug == 0.1 10:49:52 INFO - mozdevice == 0.48 10:49:52 INFO - mozfile == 1.2 10:49:52 INFO - mozhttpd == 0.7 10:49:52 INFO - mozinfo == 0.9 10:49:52 INFO - mozleak == 0.1 10:49:52 INFO - mozlog == 3.4 10:49:52 INFO - moznetwork == 0.27 10:49:52 INFO - mozprocess == 0.23 10:49:52 INFO - mozprofile == 0.28 10:49:52 INFO - mozrunner == 6.12 10:49:52 INFO - mozscreenshot == 0.1 10:49:52 INFO - mozsystemmonitor == 0.3 10:49:52 INFO - moztest == 0.7 10:49:52 INFO - mozversion == 1.4 10:49:52 INFO - psutil == 3.1.1 10:49:52 INFO - requests == 1.2.3 10:49:52 INFO - wsgiref == 0.1.2 10:49:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:49:52 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')]} 10:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:52 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')]} 10:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:52 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 0x7f46cce1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c930>, '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 0x1f3d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3dcc0>, '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': '6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618', '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 10:49:52 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 10:49:52 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 10:49:52 INFO - Using env: {'DISPLAY': ':0', 10:49:52 INFO - 'HOME': '/home/cltbld', 10:49:52 INFO - 'LANG': 'en_US.UTF-8', 10:49:52 INFO - 'LANGUAGE': 'en_US:en', 10:49:52 INFO - 'LOGNAME': 'cltbld', 10:49:52 INFO - 'MAIL': '/var/mail/cltbld', 10:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:52 INFO - 'MOZ_NO_REMOTE': '1', 10:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:52 INFO - 'NO_EM_RESTART': '1', 10:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:52 INFO - 'PWD': '/builds/slave/test', 10:49:52 INFO - 'SHELL': '/bin/bash', 10:49:52 INFO - 'SHLVL': '1', 10:49:52 INFO - 'TERM': 'linux', 10:49:52 INFO - 'TMOUT': '86400', 10:49:52 INFO - 'USER': 'cltbld', 10:49:52 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618', 10:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:52 INFO - '_': '/tools/buildbot/bin/python'} 10:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:52 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)) 10:49:52 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)) 10:49:52 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)) 10:49:52 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)) 10:49:52 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)) 10:49:52 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)) 10:49:52 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)) 10:49:52 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)) 10:49:52 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)) 10:49:52 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)) 10:49:52 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)) 10:49:52 INFO - Cleaning up... 10:49:52 INFO - Return code: 0 10:49:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:49:52 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')]} 10:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:52 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')]} 10:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:52 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 0x7f46cce1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c930>, '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 0x1f3d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3dcc0>, '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': '6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618', '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 10:49:52 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 10:49:52 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 10:49:52 INFO - Using env: {'DISPLAY': ':0', 10:49:52 INFO - 'HOME': '/home/cltbld', 10:49:52 INFO - 'LANG': 'en_US.UTF-8', 10:49:52 INFO - 'LANGUAGE': 'en_US:en', 10:49:52 INFO - 'LOGNAME': 'cltbld', 10:49:52 INFO - 'MAIL': '/var/mail/cltbld', 10:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:52 INFO - 'MOZ_NO_REMOTE': '1', 10:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:52 INFO - 'NO_EM_RESTART': '1', 10:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:52 INFO - 'PWD': '/builds/slave/test', 10:49:52 INFO - 'SHELL': '/bin/bash', 10:49:52 INFO - 'SHLVL': '1', 10:49:52 INFO - 'TERM': 'linux', 10:49:52 INFO - 'TMOUT': '86400', 10:49:52 INFO - 'USER': 'cltbld', 10:49:52 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618', 10:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:52 INFO - '_': '/tools/buildbot/bin/python'} 10:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:49:52 INFO - Cleaning up... 10:49:52 INFO - Return code: 0 10:49:52 INFO - Running post-action listener: _resource_record_post_action 10:49:52 INFO - Running post-action listener: _start_resource_monitoring 10:49:52 INFO - Starting resource monitoring. 10:49:52 INFO - [mozharness: 2016-11-08 18:49:52.613193Z] Finished create-virtualenv step (success) 10:49:52 INFO - [mozharness: 2016-11-08 18:49:52.613662Z] Running install step. 10:49:52 INFO - Running pre-action listener: _resource_record_pre_action 10:49:52 INFO - Running main action method: install 10:49:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:49:52 INFO - Reading from file tmpfile_stdout 10:49:52 INFO - Detecting whether we're running mozinstall >=1.0... 10:49:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:49:52 INFO - Reading from file tmpfile_stdout 10:49:52 INFO - Output received: 10:49:52 INFO - Usage: mozinstall [options] installer 10:49:52 INFO - Options: 10:49:52 INFO - -h, --help show this help message and exit 10:49:52 INFO - -d DEST, --destination=DEST 10:49:52 INFO - Directory to install application into. [default: 10:49:52 INFO - "/builds/slave/test"] 10:49:52 INFO - --app=APP Application being installed. [default: firefox] 10:49:52 INFO - mkdir: /builds/slave/test/build/application 10:49:52 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'] 10:49:52 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 10:50:09 INFO - Reading from file tmpfile_stdout 10:50:09 INFO - Output received: 10:50:09 INFO - /builds/slave/test/build/application/firefox/firefox 10:50:09 INFO - Running post-action listener: _resource_record_post_action 10:50:09 INFO - [mozharness: 2016-11-08 18:50:09.854583Z] Finished install step (success) 10:50:09 INFO - [mozharness: 2016-11-08 18:50:09.854826Z] Running run-tests step. 10:50:09 INFO - Running pre-action listener: _resource_record_pre_action 10:50:09 INFO - Running main action method: run_tests 10:50:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:50:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:50:09 INFO - Python 2.7.3 10:50:09 INFO - Return code: 0 10:50:09 INFO - grabbing minidump binary from tooltool 10:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:09 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 0x1f3c930>, '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 0x1f3d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3dcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:50:09 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 10:50:09 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 10:50:09 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 10:50:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:50:09 INFO - Return code: 0 10:50:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:50:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:50:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:50:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:50:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:50:09 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/EXLkjXmsRla-x_6RtV3kpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 10:50:09 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/EXLkjXmsRla-x_6RtV3kpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 10:50:09 INFO - Using env: {'DISPLAY': ':0', 10:50:09 INFO - 'HOME': '/home/cltbld', 10:50:09 INFO - 'LANG': 'en_US.UTF-8', 10:50:09 INFO - 'LANGUAGE': 'en_US:en', 10:50:09 INFO - 'LOGNAME': 'cltbld', 10:50:09 INFO - 'MAIL': '/var/mail/cltbld', 10:50:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:50:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:09 INFO - 'MOZ_NO_REMOTE': '1', 10:50:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:50:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:09 INFO - 'NO_EM_RESTART': '1', 10:50:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:09 INFO - 'PWD': '/builds/slave/test', 10:50:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:50:09 INFO - 'SHELL': '/bin/bash', 10:50:09 INFO - 'SHLVL': '1', 10:50:09 INFO - 'TERM': 'linux', 10:50:09 INFO - 'TMOUT': '86400', 10:50:09 INFO - 'USER': 'cltbld', 10:50:09 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618', 10:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:09 INFO - '_': '/tools/buildbot/bin/python'} 10:50:09 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/EXLkjXmsRla-x_6RtV3kpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 10:50:10 INFO - mozversion application_buildid: 20161108030212 10:50:10 INFO - mozversion application_changeset: f13e90d496cf1bc6dfc4fd398da33e4afe785bde 10:50:10 INFO - mozversion application_display_name: Nightly 10:50:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:50:10 INFO - mozversion application_name: Firefox 10:50:10 INFO - mozversion application_remotingname: firefox 10:50:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:50:10 INFO - mozversion application_vendor: Mozilla 10:50:10 INFO - mozversion application_version: 52.0a1 10:50:10 INFO - mozversion platform_buildid: 20161108030212 10:50:10 INFO - mozversion platform_changeset: f13e90d496cf1bc6dfc4fd398da33e4afe785bde 10:50:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:50:10 INFO - mozversion platform_version: 52.0a1 10:50:10 INFO - using testdate: 1478631010 10:50:10 INFO - actual date: 1478631010 10:50:10 INFO - starting webserver on 'localhost:57106' 10:50:10 INFO - SUITE-START | Running 2 tests 10:50:10 INFO - TEST-START | dromaeo_css 10:50:10 INFO - operating with platform_type : linux_ 10:50:10 INFO - Initialising browser for dromaeo_css test... 10:50:10 INFO - TEST-INFO | started process 16180 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp428Ze8/profile http://localhost:57106/getInfo.html) 10:50:13 INFO - PROCESS | 16180 | __metrics Screen width/height:1600/1200 10:50:13 INFO - PROCESS | 16180 | colorDepth:24 10:50:13 INFO - PROCESS | 16180 | Browser inner width/height: 1024/697 10:50:13 INFO - PROCESS | 16180 | __metrics 10:50:14 INFO - PROCESS | 16180 | 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" 10:50:14 INFO - PROCESS | 16180 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:50:14 INFO - PROCESS | 16180 | console.error: PushService: 10:50:14 INFO - PROCESS | 16180 | stateChangeProcessEnqueue: Error transitioning state 10:50:14 INFO - PROCESS | 16180 | UnknownError 10:50:15 INFO - TEST-INFO | 16180: exit 0 10:50:15 INFO - Browser initialized. 10:50:15 INFO - Running cycle 1/1 for dromaeo_css test... 10:50:15 INFO - TEST-INFO | started process 16268 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp428Ze8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:50:27 INFO - PROCESS | 16268 | RSS: Main: 172896256 10:50:27 INFO - PROCESS | 16268 | 10:51:19 INFO - PROCESS | 16268 | 1478631079146 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] 10:53:30 INFO - PROCESS | 16268 | Cycle 1(1): loaded http://localhost:57106/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57106/tests/dromaeo/cssquery-ext.html) 10:53:31 INFO - PROCESS | 16268 | RSS: Main: 305270784 10:53:31 INFO - PROCESS | 16268 | 10:56:34 INFO - PROCESS | 16268 | Cycle 1(1): loaded http://localhost:57106/tests/dromaeo/cssquery-ext.html (next: http://localhost:57106/tests/dromaeo/cssquery-jquery.html) 10:56:34 INFO - PROCESS | 16268 | RSS: Main: 275558400 10:56:34 INFO - PROCESS | 16268 | 10:59:36 INFO - PROCESS | 16268 | Cycle 1(1): loaded http://localhost:57106/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57106/tests/dromaeo/cssquery-mootools.html) 10:59:37 INFO - PROCESS | 16268 | RSS: Main: 214499328 10:59:37 INFO - PROCESS | 16268 | 11:02:39 INFO - PROCESS | 16268 | Cycle 1(1): loaded http://localhost:57106/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57106/tests/dromaeo/cssquery-prototype.html) 11:02:39 INFO - PROCESS | 16268 | RSS: Main: 259698688 11:02:39 INFO - PROCESS | 16268 | 11:05:42 INFO - PROCESS | 16268 | Cycle 1(1): loaded http://localhost:57106/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57106/tests/dromaeo/cssquery-yui.html) 11:05:43 INFO - PROCESS | 16268 | RSS: Main: 215748608 11:05:43 INFO - PROCESS | 16268 | 11:08:46 INFO - PROCESS | 16268 | Cycle 1(1): loaded http://localhost:57106/tests/dromaeo/cssquery-yui.html (next: http://localhost:57106/tests/dromaeo/cssquery-dojo.html) 11:08:47 INFO - PROCESS | 16268 | RSS: Main: 305328128 11:08:47 INFO - PROCESS | 16268 | 11:08:47 INFO - PROCESS | 16268 | __start_tp_report 11:08:47 INFO - PROCESS | 16268 | _x_x_mozilla_page_load 11:08:47 INFO - PROCESS | 16268 | _x_x_mozilla_page_load_details 11:08:47 INFO - PROCESS | 16268 | |i|pagename|runs| 11:08:47 INFO - PROCESS | 16268 | |0;dojo.html;3078.615173103362;3090.1502086926107;3096.442640324742;3110.331278775063;3133.2323580722727;5204.401493828211;5231;5290.232916227144;5300.549453296465;5313.973430132849;5173.379194496666;5244.082285600014;5264.8157314494;5314.202869569566;5342.412334643196;4734.810607575693;4746.572808447239;4789.712617242959;4806.759662016902;4812.254100614393;4860.902781944359;4894.143524883149;4952.083864485082;4955.281484184791;4989.925151122736;4752.572268495852;4883.804647814083;4897.094037603019;4922.852314430573;4997.925031124518;4774.28385742138;4803.087413391444;4821.204501257288;4828.49300823412;4843.709377437365;4780.521947805227;4836.51634836517;4868.707877527359;4871.8294859679745;4882.877928051827;5308.309919710413;5308.9469105308835;5310.468953104659;5323.148296272578;5328.413874473805;5430.56555475565;5463.180522921554;5611.410801865786;5619.129034999582;5624.437556244384;5590.24531688225;5640.633358831663;5641.943580564182;5677.460641239076;5702.7433765480655;5256.316678831728;5259.263703081571;5261.631685781997;5265.947340526584;5266.7629956652045;5445.319335083114;5758.395368486249;5765.048766953406;5777.24895763548;5817.127430885316;5378.220158077057;5460.972695136499;5493.176023596492;5497.312835895513;5526.861828454321;5562.9443705563235;5584.357798853102;5600.719964001783;5676.403977582377;5677.602567820296;5657.886842263131;5670.489655930986;5672.943270567324;5675.120356344773;5675.943240567624;5453.400125986138;5471.179323101566;5585.106382978785;5610.933922554702;5619.438056194348;4360.4767427908855;4362.563743625676;4385.210662080793;4394.231009573312;4456.064226512404;3844.3656796628243;3883.805809709503;3930.4693866328253;3940.2119576084897;4002.779847108379;5332.520073193431;5365;5398.163284690879;5398.64908780928;5423.593230507728;5636.802711905064;5706.9429305707245;5714.685692286964;5751.568632352591;5757.280339957505;5405.270288511079;5416.702081385482;5417.26866872975;5443.891122177534;5444.346678398539;4864.80540778372;4919;4923.076923076923;4954.950450495521;5014.2979982802435;5844.620099693507;5888.852778680567;5908.350081491032;5947.434993675594;5993.880122397441;5683.2895888014;5685.374608793112;5691.8861622768145;5695.117256825199;5696.886062278649;5583.330000399978;5876.500497457593;5932.5550583705535;5939.168516407793;5941.465268125889;5325.627206095691;5465.508104270476;5468.234447177478;5488.69812160335;5592.888142237051;5632.070708333079;5649.4633009864;5649.519790817826;5651.915221271602;5654.15187721845;5501.724913754216;5523.309586301712;5525.889482210253;5526.300041888557;5533.889322213614;5325.09473389517;5370.087085195604;5460.31746031746;5479.643823151482;5488.588355873246;5469.316335458067;5512.6692398456225;5516.724163791714;5522.5858060646415;5553.72231388437;5424.7558859850615;5436.238926550365;5552.083906155601;5585.357683866408;5589.329280486368;5411.053065713406;5424.186372044225;5427.701476418835;5442.183672449164;5513.173024046425 11:08:47 INFO - PROCESS | 16268 | |1;ext.html;555.8724296942219;586.563010557135;603.6438501284241;620.4694985787155;645.5255387290338;31990.520142197856;41842.79078604606;42979.78510107453;42999.3550096748;43002.784986075065;44210.33684494735;44443.555564444345;44507.77746111265;44593.55406445934;44607;7602.771916842476;8676.089010653885;8822.64709411626;8829.779255518599;8832.558372081403;7901.565413902233;8143;8150.429469937107;10104.595816167344;10377.792444151113;10466.790664186712;10523.315984460985;10523.78952420955;10529.684109476728;10531.21015923805;10395.16838652906;10492.160627149886;10504.264701470938;10531.84202236967;10541.84187237192;10204.642837500725;10397.636082737068;10400.947995259976;10402.843957340647;10404.531796069195;40305;40628.59371406307;40673.79663101665;40682;40731.7963410184;3235.7573182011206;3263.209053669377;3311.9006429807146;3347.7991320520846;3392.7625066245373;30522.38955220883;30718.232044199074;30776.53835192474;30789.538156927665;31895;4022;4114.465119534471;4146.771927543984;4162.771047592381;4234.640055595247;334397;334443;334721;335726;336686;33843.66156338454;35184.64815351865;55606;55928;55956;36214;36279.63720362762;36503.817480912425;36504.63495365012;36552;15478.9226053869;15503.922480387751;15514.146721930401;15639.68720625581;15641.68716625684;11558.133140014532;13032.934835325763;13125.409356578786;13127.277999709917;13133.868661313456;8154.2253485918745;8301.418900677016;8598.613062412207;8604.827903441896;8669.306455483546;3312.0601867934492;3318.767686261987;3331.983340083284;3366.4613661814483;3390.135515443546;914.3645166609143;1021.8569400283966;1026.7638443158116;1070.9344202518544;1072.7157303314627;31152.22119447032;31327.843360783507;31442.842785786383;31751;32230.19424514406;1095.9726006849892;1117.9385133817718;1130.4573804573686;1135.2677522997785;1198.532572296805;16479.76401769872;16508.17459127039;16568.83431165697;16590.83409165893;16968.40610578624;529768;532808;533834;535061;536264;55919.16121258184;56937.43062569321;57012.00915935927;57171.71414142902;61701;1261.1235191541973;1298.480607756886;1361.4894414594528;1369.2400717601627;1401.4884567132924;28978.56532151977;32099.358012839144;32531.51202732008;33941.83029084839;34058.65941340555;53468.73265633647;54290;54357.45642543682;54424;54500;418895;422317;422683;426166;428191;24871.50256994886;25397;28152.85923570369;28382.574261385682;36119.63880361268;38339.42490862695;39871;40399;41403;48143.75928120477;37609.623903761705;40237;40293;41172;41206;40207.396889046104;40513.79743101266;40961;41628.58371416368;42430.36354454747;40534.39198412085;40907.1818563633;41721.16557668769;41730.58269417267;42335.7883210582;32637.836810815796;36793.26413471662;37047.25905481821;37533.62466375301;37668.81165594154;28246.576301355086;28411.857940710164;28425;28455.28861778472;28544.57183142296 11:08:47 INFO - PROCESS | 16268 | |2;jquery.html;394.1702715783278;398.45411785853383;401.7328476563086;404.7328763016409;420.92243855729333;13867.930660346708;16699;17538.29846806128;19453.70819437708;19504.804951950493;14440.783388249185;14878.181700006495;17102.144892755376;17383.73924391135;17738.29046838128;5153.30430391897;5557.3331200256025;5588.86027849303;5590.608657393984;5595.132754423071;5533.944660553403;5575.69333686647;5625.971870140644;5635.070213414781;5636.041872881599;5438.320209973754;5562.360328562207;5593.496585307322;5597.74810133545;5604.663720176782;5279.736013199363;5558.888822223553;5584.91622625661;5605.551555875561;5624.0439125348585;5430.208031349645;5534.667919924817;5539.473749993744;5553.4724201200825;5554.361248456398;13741.519046833313;14340.64148396288;21990.120395184174;22175.556488870134;22229.888850555806;2312.8034117100065;2341.94145146371;2377.9286621401384;2383.416063064543;2576.6220376034016;10574.735631609194;10927.617533386294;11838.052955763604;13618.727625447535;13862.514811981533;1813.9727904081449;1822.325739476389;1836.0079313944386;1849.3157531713218;1884.9717254241198;69320;82094.58952705198;85459.57270213672;86336;90543.09456905413;10954.178436617127;11017.173711971634;11285.557904838939;11290.717732056764;11362.204645674889;15675.921620391826;15891.523254302389;15905;15913.124778137313;15917.124558149413;6912.619805910723;7285.4171666266575;7743.303102720783;7761.262680045386;8024.157463466368;7830.216978302238;7849.568273744884;7854.136045035041;8073.9192608074345;8100.8379832403025;4660.953390466119;4756.453007904066;4829.879253018703;4884.3161957326;4926.581240594518;1771.8097564963864;1869.6073824496737;1951.5218771401098;2009.1260301768777;2064.8554601177775;869.5304535550858;915.6154415145655;993.9652112176184;1060.9045185933303;1064.7338165458636;18321.267149313877;18618.348357807412;18757.77949961248;18837.43487695344;19406.2237510498;964.6430820596424;969.9321047526605;975.1564896364594;988.6935050134481;1031.742064483879;10042.246831487668;10454.947725261325;10561.735956600993;10593.152547796159;10605.204609654307;327412;328117;331377;435267;472007;68920;94378.5281073604;95900.52049739707;95984;97462;997.7156510394502;1018.3431686562274;1041.6302212714377;1057.3444464431948;1059.2003037706481;15976.840231597535;15977.81829990286;16094.67810643804;17206.82793172102;17278.568035798704;39488.40767388434;39899.800500997306;39906.201875961735;40413.393799092446;41062;55237.72381138069;55328.44671553233;55560;56401;57540.1368979474;6515.153030106056;7017.333353331425;7170.139583250043;7217.963910180415;7564.163438710483;9552.42685438876;10707.143428525855;10928.508217130408;10942.507587158438;11097.38964356968;9419.481928493999;9727.221822254343;10031.29780915329;10064.144547713526;10072.726363931604;9322.580483878377;9811.656592019244;9833.901660983298;9983.90177080535;10008;9731.708048758548;9801.50992450389;9880.604775808888;10220.488975551341;10421.709899126983;6423.197100362455;6821.590704557742;7087.114110736158;7307;7458.888116678146;8590.78523036929;9706;9802.558884850341;10065.69802905914;10240.48797560134 11:08:47 INFO - PROCESS | 16268 | |3;mootools.html;1423.1958943197094;1467.603746988313;1560.3290585048433;1698.7366958121495;1709.2564734340563;7792.220777922212;8372.41393102483;8378.790530236733;8382.413231073828;8383.413161078726;7186.964065179667;7376.926230737691;7814.843703125934;7988.520688758678;8227.67089316428;2221.0449506712107;2251.583457060449;2251.966220506694;2253.9436514087197;2256.0975609756065;2234.575430668176;2264.320703788865;2303.101790301775;2304.700388949434;2305.8385912986096;1931.3240365871902;2000.5098750806073;2002.839772818171;2013.6979453082008;2149.570085982802;2174.08688350893;2194.0455901682817;2207.128184367182;2208.083645287204;2211.292386436341;2231.1187081102876;2256.785605367504;2264.8754318512474;2291.9885400573057;2298.333483289844;8200.671973121069;8207.343412526983;8270.958645206736;8290.336773058201;8310.501369917763;4999.675021123615;5139.203423469331;5140.460251673595;5144.43411224765;5153.458886816905;3107.64262109858;3290.177455636091;3325.1022223999385;3349.698527132545;3368.4105281575626;1113.4766659669942;1141.2125633312987;1192.1893112683372;1201.7656556971394;1211.9697007574794;11265.127392514938;11272.887271127347;11274.605388811435;11332.830007549894;11357.659270221906;4275.593818587229;4419.558044195554;4472.2620767573635;4518.615917647036;4525.796339164745;9560.187384072431;9562.378445401027;9565.186959108414;9570.665026724031;9570.712878613653;5070.7464626768515;5072.087024335655;5073.34046573943;5073.695578265316;5077.695338279715;4474.798634061475;4638.95361046392;4676.929846052312;4682.5015994882;4685.344051832746;3738.9626103738615;3739;3774.6225377462033;3825.3305671507374;3829.7893615851394;1272.2239433945285;1282.9807552886714;1284.3770771175973;1291.1671971578467;1314.0932756398247;867.5878957495265;879.9164079412445;894.4409743910056;924.7872989212519;935.6912218967724;5250.396204436539;5408.810691625853;5460.5085542301385;5473.75368108436;5500.6424582402815;937.3906960475746;939.7133874168308;960.2845879819579;963.710886733977;978.8042391521724;3556.982215088908;3696.722745794076;3730.813459327023;3825.617438256152;3843.942340864889;10060.446675432922;10179.389236645826;10303.124234440156;10338.896611033944;10387.792244155225;9553.426794392359;10166.745831354126;10198.490075496196;10208.948955255177;10218.489075546193;7489.550626962399;7828.608569571613;7844.294013538809;7844.529328240324;7853.842923141505;5478.671279723229;5574.470425309752;5610.354809196831;5689.2319536862;5754.395788442153;8923.509206993418;9159.038300978302;9185.494797786187;9489.952550237205;9496.667616633385;9276.582553784961;9417.293702972442;9478.57346419399;9559.426434413957;9579.036297559123;7020.508564400443;7055.61194134307;7141.392981596622;7181.425485961215;7210.134783825974;7495.587742674205;7556.962215188889;7563.394928405824;7563.432742544222;7563.546187228784;5562.749676264497;6852.862942741018;6977.1278590176225;6983.057287266357;7098.25468325839;6676.732930682719;6792.558483698544;6826.419754320938;6854.588724676535;6932.549384290005;6120.846978825565;6278.277998030285;6330.240371155491;6330.8100756977365;6331.0819931110655;4726.550977657117;4767.118083154627;4780.904381912412;4865.610751139971;4948.826791062295;4750.5249475052215;4776;4830.637702172281;4832.758362081952;4889.095517329305 11:08:47 INFO - PROCESS | 16268 | |4;prototype.html;324.3011310625601;334.620206066115;337.4297437330909;337.5021842781897;342.95884493860734;5067.680669161696;5197;5238.895222095561;5260.973695131529;5271.367435907691;4999.97500512395;5071.137906555885;5156.407013193484;5165.974170129153;5175.378954525453;4116.650084742801;4118.773467459296;4128.174365126986;4130.628243458088;4138.33786594145;4012.277789997799;4070.124923141524;4134.346261495396;4144.171165766844;4145.523264824538;4041.4139949707273;4059.4722686050773;4061.6344528992386;4067.430559721641;4069.9186016279805;4043.97978010111;4052.9797351013353;4053.716239863211;4077.8572749953905;4078.714489985702;3616.2405894762132;3616.801075940822;3617.9095522611883;3622.7826330420257;3623.2572322673786;4973.303737476756;5047.520485553867;5069.822556210515;5071.695698258116;5076.111680455942;4626;4634.559716826896;4654.976725116387;4655.4180727409075;4658.790354434024;5424.833660762955;5426.240326354314;5434.945650543484;5458.208559758813;5467.753951072212;3852.3451013327804;3927.3519869221545;3938.9015274618077;3958.960410395888;3963.564007959122;5642.858928526779;5656;5665.688387138705;5669.688167150846;5671.688057156814;4021.678265738734;4023.973886658883;4025.6587032762736;4026.4362989181536;4031.7422243543124;3970.2059588082498;4023.3964905264443;4050.311447054008;4051.6758659307184;4071.206114807584;4626.553217852721;4627.398438203079;4638.768061596907;4644.233701439292;4653.139169253631;5505.229267902497;5508.20131080999;5518.44815518453;5523.171524271311;5524.502794748492;1262.722201115753;1295.0028478071831;1334.9332533373292;1335.3723749837561;1349.6907999240916;924.9583768730423;928.4893308680199;953.7377221264207;956.1776871890307;960.9423434593947;5131.948680513147;5136.255242989746;5137.9743101285;5143.742812859342;5153.500552232164;5376.494581517181;5379.515843574097;5400.459954004568;5408.4050754416985;5409.754951695081;4817.867801066746;5101.194343111274;5142.614303927146;5146.536811686966;5146.588272938231;2789.302674331417;2819.4502072096157;2825.27955371379;2829.5331270340575;2836.950328378472;5524.226608274845;5525.226468294361;5529.917051244234;5555.916661250004;5560.555155587544;5206.349206349207;5392.203381365049;5415.296011518478;5431.429699881534;5452.427495113036;5528.944710552843;5552.861178470571;5556.777508948025;5557.638753481092;5589.189567512769;5179.1355112160345;5313.415524292402;5322.498425739896;5325.227841962971;5370.409254981871;5266.447023062523;5273.44628813969;5275.973620131875;5283.418823929442;5320.494553017457;5495.038368285614;5519.2824932758485;5524.768010713617;5528.226048353315;5535.833924982257;3685.207680348738;3854.730168888263;3864.8260828262232;3879.3512757077565;3905.258000979805;5239.764210610608;5253.23828044939;5256.237845512455;5264.842054738364;5271.551918087006;5305.814296499604;5378.462153784747;5410.07942180536;5418.295621569171;5440.7551660174595;5385.353757549119;5387.218853266333;5399.757010934596;5417.485338892799;5417.566594672496;5258.817590699817;5377.408485066718;5385.676859388449;5402.243685883901;5419;5418.322709661293;5432.940576587527;5457;5457.5633949283165;5474.835754927359;5330.573554115584;5338.145896656516;5340.145576707863;5343.4389389113585;5346.304980352529 11:08:47 INFO - PROCESS | 16268 | |5;yui.html;684.7671791590861;687.281790528897;702.7961891051596;729.18331468755;750.834816340405;12914.225146491206;13325.533606323781;13339.599812005632;13627.523036693718;14266.215358155298;14629.707405851903;14758.40966361347;14772;14836.925815370909;14845.406183752664;657.0374401501799;775.2789905387987;792.7582087463321;794.2216627704853;796.2873228460525;673.5924765516866;763.7517806712813;787.6140691061368;795.5147360110328;795.5306369242146;825.5129473610568;827.548985802736;828.1925123005052;833.7082021292559;834.5034704350901;695.7147569496482;830.1242189490085;830.1988581019345;830.3564737328559;830.6718846055774;524.6825670469387;586.1500823805499;606.0364021206259;609.0133982947609;610.0757352610798;12890.87109128906;12904.22574645515;12924.224546527144;12944.288064156468;12944.546940857119;10962.177836662202;11044.392558409285;11279.774404511863;12629.557965471164;13230.603081907559;10355.637552685619;10459.320144190679;10464.21518386124;10517.894821051768;10910.399928003957;3587.3542762302777;3601.45978103284;3648.21563363878;3764.416515440111;3764.4729737836724;52970.735146324405;56388.71805640987;56502;64603.35396646067;65028.67485662589;9880.950595246977;9888.357256778287;9945.80108397828;9952.601895924226;10090.192784577217;17405.912970435067;17532.386366477112;17563.121843907753;17569.648607027786;17577.560560986076;7209.927900721031;7424.109106907205;7807.570583617842;7863.488873223222;7883.487573307717;4342.609165175149;4467.218236808546;4490.663200259994;4681.157391669464;4695.272232803921;3321.817300048472;3412.232247744287;3448.7412094585798;3448.758586898893;3451.447768357051;614.9016157414792;616.3528295289927;617.3826173826174;636.462189449914;644.2462319086679;565.2369301443019;568.5707290995272;582.7989343676425;661.3254480429935;664.8138521214067;8208.343332533503;8259.876101858477;8476.830463390697;8570.614322355508;8880;611.2847967877594;612.9724162412703;693.7606525748608;699.951003429755;711.0862541633976;3839.0786211309087;4003.959960400417;4039.4748682671066;4062.5734297898293;4094.570070142592;87936;88046.55976720076;88844.5557772207;89979.55010224906;90077.54961225152;49781.75109124431;50985.49014509882;59256.11115833266;67806.66096669485;76119;68846.311536884;71400;71646;71658.64170679217;72497;7904.881426778718;8190.754277371689;8224.835503289782;8240.175982401712;8252.711155109542;45892.77053614711;46005;46676.7666161667;48622.75688621534;49991.50008499868;46682;48888.75555622199;57867.42132578789;58223.41776582349;63333.366666332746;10131.949340253252;10153.39079655223;10434.06093451593;11082.335059896432;11649.184557080924;12283.75432491363;12352.320622365856;12430.067744919348;12627;12823.422945967268;11722.472488738198;11782.587609433629;11838.289702617525;12269.386530673251;12607.49570017189;11184.94407527957;11471.139664525028;11865.288082715064;11917.404129793302;11922.701932451759;11952.58165964187;12066.276023438622;12128.696782580506;12352.25886446816;12947.935260323638;8845.292376609985;9008.099190080939;9212.723618291462;9318;9445;9293.117153870371;9523.142917137491;9689.70930872075;9830.852537212091;9854.458004809518 11:08:47 INFO - PROCESS | 16268 | __end_tp_report 11:08:47 INFO - PROCESS | 16268 | __start_cc_report 11:08:47 INFO - PROCESS | 16268 | _x_x_mozilla_cycle_collect,1262 11:08:47 INFO - PROCESS | 16268 | __end_cc_report 11:08:47 INFO - PROCESS | 16268 | __startTimestamp1478632127094__endTimestamp 11:08:47 INFO - PROCESS | 16268 | 11:08:47 INFO - PROCESS | 16268 | ------- Summary: start ------- 11:08:47 INFO - PROCESS | 16268 | Number of tests: 6 11:08:47 INFO - PROCESS | 16268 | 11:08:47 INFO - PROCESS | 16268 | [#0] dojo.html Cycles:165 Average:5256.68 Median:5436.24 stddev:573.95 (10.6%) stddev-sans-first:549.69 11:08:47 INFO - PROCESS | 16268 | Values: 3078.6 3090.2 3096.4 3110.3 3133.2 5204.4 5231.0 5290.2 5300.5 5314.0 5173.4 5244.1 5264.8 5314.2 5342.4 4734.8 4746.6 4789.7 4806.8 4812.3 4860.9 4894.1 4952.1 4955.3 4989.9 4752.6 4883.8 4897.1 4922.9 4997.9 4774.3 4803.1 4821.2 4828.5 4843.7 4780.5 4836.5 4868.7 4871.8 4882.9 5308.3 5308.9 5310.5 5323.1 5328.4 5430.6 5463.2 5611.4 5619.1 5624.4 5590.2 5640.6 5641.9 5677.5 5702.7 5256.3 5259.3 5261.6 5265.9 5266.8 5445.3 5758.4 5765.0 5777.2 5817.1 5378.2 5461.0 5493.2 5497.3 5526.9 5562.9 5584.4 5600.7 5676.4 5677.6 5657.9 5670.5 5672.9 5675.1 5675.9 5453.4 5471.2 5585.1 5610.9 5619.4 4360.5 4362.6 4385.2 4394.2 4456.1 3844.4 3883.8 3930.5 3940.2 4002.8 5332.5 5365.0 5398.2 5398.6 5423.6 5636.8 5706.9 5714.7 5751.6 5757.3 5405.3 5416.7 5417.3 5443.9 5444.3 4864.8 4919.0 4923.1 4955.0 5014.3 5844.6 5888.9 5908.4 5947.4 5993.9 5683.3 5685.4 5691.9 5695.1 5696.9 5583.3 5876.5 5932.6 5939.2 5941.5 5325.6 5465.5 5468.2 5488.7 5592.9 5632.1 5649.5 5649.5 5651.9 5654.2 5501.7 5523.3 5525.9 5526.3 5533.9 5325.1 5370.1 5460.3 5479.6 5488.6 5469.3 5512.7 5516.7 5522.6 5553.7 5424.8 5436.2 5552.1 5585.4 5589.3 5411.1 5424.2 5427.7 5442.2 5513.2 11:08:47 INFO - PROCESS | 16268 | 11:08:47 INFO - PROCESS | 16268 | [#1] ext.html Cycles:180 Average:57872.18 Median:36246.82 stddev:116418.67 (321.2%) stddev-sans-first:116665.72 11:08:47 INFO - PROCESS | 16268 | Values: 555.9 586.6 603.6 620.5 645.5 31990.5 41842.8 42979.8 42999.4 43002.8 44210.3 44443.6 44507.8 44593.6 44607.0 7602.8 8676.1 8822.6 8829.8 8832.6 7901.6 8143.0 8150.4 10104.6 10377.8 10466.8 10523.3 10523.8 10529.7 10531.2 10395.2 10492.2 10504.3 10531.8 10541.8 10204.6 10397.6 10400.9 10402.8 10404.5 40305.0 40628.6 40673.8 40682.0 40731.8 3235.8 3263.2 3311.9 3347.8 3392.8 30522.4 30718.2 30776.5 30789.5 31895.0 4022.0 4114.5 4146.8 4162.8 4234.6 334397.0 334443.0 334721.0 335726.0 336686.0 33843.7 35184.6 55606.0 55928.0 55956.0 36214.0 36279.6 36503.8 36504.6 36552.0 15478.9 15503.9 15514.1 15639.7 15641.7 11558.1 13032.9 13125.4 13127.3 13133.9 8154.2 8301.4 8598.6 8604.8 8669.3 3312.1 3318.8 3332.0 3366.5 3390.1 914.4 1021.9 1026.8 1070.9 1072.7 31152.2 31327.8 31442.8 31751.0 32230.2 1096.0 1117.9 1130.5 1135.3 1198.5 16479.8 16508.2 16568.8 16590.8 16968.4 529768.0 532808.0 533834.0 535061.0 536264.0 55919.2 56937.4 57012.0 57171.7 61701.0 1261.1 1298.5 1361.5 1369.2 1401.5 28978.6 32099.4 32531.5 33941.8 34058.7 53468.7 54290.0 54357.5 54424.0 54500.0 418895.0 422317.0 422683.0 426166.0 428191.0 24871.5 25397.0 28152.9 28382.6 36119.6 38339.4 39871.0 40399.0 41403.0 48143.8 37609.6 40237.0 40293.0 41172.0 41206.0 40207.4 40513.8 40961.0 41628.6 42430.4 40534.4 40907.2 41721.2 41730.6 42335.8 32637.8 36793.3 37047.3 37533.6 37668.8 28246.6 28411.9 28425.0 28455.3 28544.6 11:08:47 INFO - PROCESS | 16268 | 11:08:47 INFO - PROCESS | 16268 | [#2] jquery.html Cycles:180 Average:25209.76 Median:20741.46 stddev:64208.25 (309.6%) stddev-sans-first:64361.33 11:08:47 INFO - PROCESS | 16268 | Values: 394.2 398.5 401.7 404.7 420.9 13867.9 16699.0 17538.3 19453.7 19504.8 14440.8 14878.2 17102.1 17383.7 17738.3 5153.3 5557.3 5588.9 5590.6 5595.1 5533.9 5575.7 5626.0 5635.1 5636.0 5438.3 5562.4 5593.5 5597.7 5604.7 5279.7 5558.9 5584.9 5605.6 5624.0 5430.2 5534.7 5539.5 5553.5 5554.4 13741.5 14340.6 21990.1 22175.6 22229.9 2312.8 2341.9 2377.9 2383.4 2576.6 10574.7 10927.6 11838.1 13618.7 13862.5 1814.0 1822.3 1836.0 1849.3 1885.0 69320.0 82094.6 85459.6 86336.0 90543.1 10954.2 11017.2 11285.6 11290.7 11362.2 15675.9 15891.5 15905.0 15913.1 15917.1 6912.6 7285.4 7743.3 7761.3 8024.2 7830.2 7849.6 7854.1 8073.9 8100.8 4661.0 4756.5 4829.9 4884.3 4926.6 1771.8 1869.6 1951.5 2009.1 2064.9 869.5 915.6 994.0 1060.9 1064.7 18321.3 18618.3 18757.8 18837.4 19406.2 964.6 969.9 975.2 988.7 1031.7 10042.2 10454.9 10561.7 10593.2 10605.2 327412.0 328117.0 331377.0 435267.0 472007.0 68920.0 94378.5 95900.5 95984.0 97462.0 997.7 1018.3 1041.6 1057.3 1059.2 15976.8 15977.8 16094.7 17206.8 17278.6 39488.4 39899.8 39906.2 40413.4 41062.0 55237.7 55328.4 55560.0 56401.0 57540.1 6515.2 7017.3 7170.1 7218.0 7564.2 9552.4 10707.1 10928.5 10942.5 11097.4 9419.5 9727.2 10031.3 10064.1 10072.7 9322.6 9811.7 9833.9 9983.9 10008.0 9731.7 9801.5 9880.6 10220.5 10421.7 6423.2 6821.6 7087.1 7307.0 7458.9 8590.8 9706.0 9802.6 10065.7 10240.5 11:08:47 INFO - PROCESS | 16268 | 11:08:47 INFO - PROCESS | 16268 | [#3] mootools.html Cycles:180 Average:5389.31 Median:5071.42 stddev:2998.62 (59.1%) stddev-sans-first:2992.22 11:08:47 INFO - PROCESS | 16268 | Values: 1423.2 1467.6 1560.3 1698.7 1709.3 7792.2 8372.4 8378.8 8382.4 8383.4 7187.0 7376.9 7814.8 7988.5 8227.7 2221.0 2251.6 2252.0 2253.9 2256.1 2234.6 2264.3 2303.1 2304.7 2305.8 1931.3 2000.5 2002.8 2013.7 2149.6 2174.1 2194.0 2207.1 2208.1 2211.3 2231.1 2256.8 2264.9 2292.0 2298.3 8200.7 8207.3 8271.0 8290.3 8310.5 4999.7 5139.2 5140.5 5144.4 5153.5 3107.6 3290.2 3325.1 3349.7 3368.4 1113.5 1141.2 1192.2 1201.8 1212.0 11265.1 11272.9 11274.6 11332.8 11357.7 4275.6 4419.6 4472.3 4518.6 4525.8 9560.2 9562.4 9565.2 9570.7 9570.7 5070.7 5072.1 5073.3 5073.7 5077.7 4474.8 4639.0 4676.9 4682.5 4685.3 3739.0 3739.0 3774.6 3825.3 3829.8 1272.2 1283.0 1284.4 1291.2 1314.1 867.6 879.9 894.4 924.8 935.7 5250.4 5408.8 5460.5 5473.8 5500.6 937.4 939.7 960.3 963.7 978.8 3557.0 3696.7 3730.8 3825.6 3843.9 10060.4 10179.4 10303.1 10338.9 10387.8 9553.4 10166.7 10198.5 10208.9 10218.5 7489.6 7828.6 7844.3 7844.5 7853.8 5478.7 5574.5 5610.4 5689.2 5754.4 8923.5 9159.0 9185.5 9490.0 9496.7 9276.6 9417.3 9478.6 9559.4 9579.0 7020.5 7055.6 7141.4 7181.4 7210.1 7495.6 7557.0 7563.4 7563.4 7563.5 5562.7 6852.9 6977.1 6983.1 7098.3 6676.7 6792.6 6826.4 6854.6 6932.5 6120.8 6278.3 6330.2 6330.8 6331.1 4726.6 4767.1 4780.9 4865.6 4948.8 4750.5 4776.0 4830.6 4832.8 4889.1 11:08:47 INFO - PROCESS | 16268 | 11:08:47 INFO - PROCESS | 16268 | [#4] prototype.html Cycles:180 Average:4524.36 Median:5177.26 stddev:1310.53 (25.3%) stddev-sans-first:1275.72 11:08:47 INFO - PROCESS | 16268 | Values: 324.3 334.6 337.4 337.5 343.0 5067.7 5197.0 5238.9 5261.0 5271.4 5000.0 5071.1 5156.4 5166.0 5175.4 4116.7 4118.8 4128.2 4130.6 4138.3 4012.3 4070.1 4134.3 4144.2 4145.5 4041.4 4059.5 4061.6 4067.4 4069.9 4044.0 4053.0 4053.7 4077.9 4078.7 3616.2 3616.8 3617.9 3622.8 3623.3 4973.3 5047.5 5069.8 5071.7 5076.1 4626.0 4634.6 4655.0 4655.4 4658.8 5424.8 5426.2 5434.9 5458.2 5467.8 3852.3 3927.4 3938.9 3959.0 3963.6 5642.9 5656.0 5665.7 5669.7 5671.7 4021.7 4024.0 4025.7 4026.4 4031.7 3970.2 4023.4 4050.3 4051.7 4071.2 4626.6 4627.4 4638.8 4644.2 4653.1 5505.2 5508.2 5518.4 5523.2 5524.5 1262.7 1295.0 1334.9 1335.4 1349.7 925.0 928.5 953.7 956.2 960.9 5131.9 5136.3 5138.0 5143.7 5153.5 5376.5 5379.5 5400.5 5408.4 5409.8 4817.9 5101.2 5142.6 5146.5 5146.6 2789.3 2819.5 2825.3 2829.5 2837.0 5524.2 5525.2 5529.9 5555.9 5560.6 5206.3 5392.2 5415.3 5431.4 5452.4 5528.9 5552.9 5556.8 5557.6 5589.2 5179.1 5313.4 5322.5 5325.2 5370.4 5266.4 5273.4 5276.0 5283.4 5320.5 5495.0 5519.3 5524.8 5528.2 5535.8 3685.2 3854.7 3864.8 3879.4 3905.3 5239.8 5253.2 5256.2 5264.8 5271.6 5305.8 5378.5 5410.1 5418.3 5440.8 5385.4 5387.2 5399.8 5417.5 5417.6 5258.8 5377.4 5385.7 5402.2 5419.0 5418.3 5432.9 5457.0 5457.6 5474.8 5330.6 5338.1 5340.1 5343.4 5346.3 11:08:47 INFO - PROCESS | 16268 | 11:08:47 INFO - PROCESS | 16268 | [#5] yui.html Cycles:180 Average:16606.18 Median:29218.00 stddev:22461.16 (76.9%) stddev-sans-first:22492.35 11:08:47 INFO - PROCESS | 16268 | Values: 684.8 687.3 702.8 729.2 750.8 12914.2 13325.5 13339.6 13627.5 14266.2 14629.7 14758.4 14772.0 14836.9 14845.4 657.0 775.3 792.8 794.2 796.3 673.6 763.8 787.6 795.5 795.5 825.5 827.5 828.2 833.7 834.5 695.7 830.1 830.2 830.4 830.7 524.7 586.2 606.0 609.0 610.1 12890.9 12904.2 12924.2 12944.3 12944.5 10962.2 11044.4 11279.8 12629.6 13230.6 10355.6 10459.3 10464.2 10517.9 10910.4 3587.4 3601.5 3648.2 3764.4 3764.5 52970.7 56388.7 56502.0 64603.4 65028.7 9881.0 9888.4 9945.8 9952.6 10090.2 17405.9 17532.4 17563.1 17569.6 17577.6 7209.9 7424.1 7807.6 7863.5 7883.5 4342.6 4467.2 4490.7 4681.2 4695.3 3321.8 3412.2 3448.7 3448.8 3451.4 614.9 616.4 617.4 636.5 644.2 565.2 568.6 582.8 661.3 664.8 8208.3 8259.9 8476.8 8570.6 8880.0 611.3 613.0 693.8 700.0 711.1 3839.1 4004.0 4039.5 4062.6 4094.6 87936.0 88046.6 88844.6 89979.6 90077.5 49781.8 50985.5 59256.1 67806.7 76119.0 68846.3 71400.0 71646.0 71658.6 72497.0 7904.9 8190.8 8224.8 8240.2 8252.7 45892.8 46005.0 46676.8 48622.8 49991.5 46682.0 48888.8 57867.4 58223.4 63333.4 10131.9 10153.4 10434.1 11082.3 11649.2 12283.8 12352.3 12430.1 12627.0 12823.4 11722.5 11782.6 11838.3 12269.4 12607.5 11184.9 11471.1 11865.3 11917.4 11922.7 11952.6 12066.3 12128.7 12352.3 12947.9 8845.3 9008.1 9212.7 9318.0 9445.0 9293.1 9523.1 9689.7 9830.9 9854.5 11:08:47 INFO - PROCESS | 16268 | -------- Summary: end -------- 11:08:47 INFO - PROCESS | 16268 | 11:08:47 INFO - TEST-INFO | 16268: exit 0 11:08:47 INFO - TEST-OK | dromaeo_css | took 1117844ms 11:08:47 INFO - TEST-START | kraken 11:08:47 INFO - operating with platform_type : linux_ 11:08:47 INFO - Initialising browser for kraken test... 11:08:47 INFO - TEST-INFO | started process 16572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp46bpYJ/profile http://localhost:57106/getInfo.html) 11:08:51 INFO - PROCESS | 16572 | __metrics Screen width/height:1600/1200 11:08:51 INFO - PROCESS | 16572 | colorDepth:24 11:08:51 INFO - PROCESS | 16572 | Browser inner width/height: 1024/697 11:08:51 INFO - PROCESS | 16572 | __metrics 11:08:52 INFO - PROCESS | 16572 | 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" 11:08:52 INFO - PROCESS | 16572 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:08:52 INFO - PROCESS | 16572 | console.error: PushService: 11:08:52 INFO - PROCESS | 16572 | stateChangeProcessEnqueue: Error transitioning state 11:08:52 INFO - PROCESS | 16572 | UnknownError 11:08:53 INFO - TEST-INFO | 16572: exit 0 11:08:53 INFO - Browser initialized. 11:08:53 INFO - Running cycle 1/1 for kraken test... 11:08:53 INFO - TEST-INFO | started process 16656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp46bpYJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:09:05 INFO - PROCESS | 16656 | RSS: Main: 173162496 11:09:05 INFO - PROCESS | 16656 | 11:09:08 INFO - PROCESS | 16656 | Cycle 1(1): loaded http://localhost:57106/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57106/tests/kraken/driver.html?testName=audio-beat-detection) 11:09:09 INFO - PROCESS | 16656 | RSS: Main: 230600704 11:09:09 INFO - PROCESS | 16656 | 11:09:11 INFO - PROCESS | 16656 | Cycle 1(1): loaded http://localhost:57106/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57106/tests/kraken/driver.html?testName=audio-dft) 11:09:12 INFO - PROCESS | 16656 | RSS: Main: 216625152 11:09:12 INFO - PROCESS | 16656 | 11:09:15 INFO - PROCESS | 16656 | Cycle 1(1): loaded http://localhost:57106/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57106/tests/kraken/driver.html?testName=audio-fft) 11:09:16 INFO - PROCESS | 16656 | RSS: Main: 296566784 11:09:16 INFO - PROCESS | 16656 | 11:09:18 INFO - PROCESS | 16656 | Cycle 1(1): loaded http://localhost:57106/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57106/tests/kraken/driver.html?testName=audio-oscillator) 11:09:18 INFO - PROCESS | 16656 | RSS: Main: 209809408 11:09:18 INFO - PROCESS | 16656 | 11:09:20 INFO - PROCESS | 16656 | Cycle 1(1): loaded http://localhost:57106/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57106/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:09:21 INFO - PROCESS | 16656 | RSS: Main: 212434944 11:09:21 INFO - PROCESS | 16656 | 11:09:24 INFO - PROCESS | 16656 | Cycle 1(1): loaded http://localhost:57106/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57106/tests/kraken/driver.html?testName=imaging-darkroom) 11:09:25 INFO - PROCESS | 16656 | RSS: Main: 248197120 11:09:25 INFO - PROCESS | 16656 | 11:09:28 INFO - PROCESS | 16656 | Cycle 1(1): loaded http://localhost:57106/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57106/tests/kraken/driver.html?testName=imaging-desaturate) 11:09:29 INFO - PROCESS | 16656 | RSS: Main: 246657024 11:09:29 INFO - PROCESS | 16656 | 11:09:31 INFO - PROCESS | 16656 | Cycle 1(1): loaded http://localhost:57106/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57106/tests/kraken/driver.html?testName=json-parse-financial) 11:09:32 INFO - PROCESS | 16656 | RSS: Main: 247111680 11:09:32 INFO - PROCESS | 16656 | 11:09:33 INFO - PROCESS | 16656 | Cycle 1(1): loaded http://localhost:57106/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57106/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:09:34 INFO - PROCESS | 16656 | RSS: Main: 209420288 11:09:34 INFO - PROCESS | 16656 | 11:09:36 INFO - PROCESS | 16656 | Cycle 1(1): loaded http://localhost:57106/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57106/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:09:36 INFO - PROCESS | 16656 | RSS: Main: 217088000 11:09:36 INFO - PROCESS | 16656 | 11:09:38 INFO - PROCESS | 16656 | Cycle 1(1): loaded http://localhost:57106/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57106/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:09:39 INFO - PROCESS | 16656 | RSS: Main: 226443264 11:09:39 INFO - PROCESS | 16656 | 11:09:41 INFO - PROCESS | 16656 | Cycle 1(1): loaded http://localhost:57106/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:09:42 INFO - PROCESS | 16656 | RSS: Main: 234659840 11:09:42 INFO - PROCESS | 16656 | 11:09:45 INFO - PROCESS | 16656 | Cycle 1(1): loaded http://localhost:57106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:09:46 INFO - PROCESS | 16656 | RSS: Main: 231280640 11:09:46 INFO - PROCESS | 16656 | 11:09:47 INFO - PROCESS | 16656 | Cycle 1(1): loaded http://localhost:57106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57106/tests/kraken/driver.html?testName=ai-astar) 11:09:47 INFO - PROCESS | 16656 | RSS: Main: 281690112 11:09:47 INFO - PROCESS | 16656 | 11:09:47 INFO - PROCESS | 16656 | __start_tp_report 11:09:47 INFO - PROCESS | 16656 | _x_x_mozilla_page_load 11:09:47 INFO - PROCESS | 16656 | _x_x_mozilla_page_load_details 11:09:47 INFO - PROCESS | 16656 | |i|pagename|runs| 11:09:47 INFO - PROCESS | 16656 | |0;ai-astar;105;112;114;113;114;112;112;112;112;113 11:09:47 INFO - PROCESS | 16656 | |1;audio-beat-detection;155;127;121;159;126;125;123;123;162;124 11:09:47 INFO - PROCESS | 16656 | |2;audio-dft;162;161;161;163;161;162;163;162;161;160 11:09:47 INFO - PROCESS | 16656 | |3;audio-fft;75;76;76;100;76;76;76;75;101;75 11:09:47 INFO - PROCESS | 16656 | |4;audio-oscillator;82;82;117;83;82;82;101;82;83;113 11:09:47 INFO - PROCESS | 16656 | |5;imaging-gaussian-blur;116;117;116;116;117;116;117;117;117;116 11:09:47 INFO - PROCESS | 16656 | |6;imaging-darkroom;146;146;145;147;145;145;145;147;145;145 11:09:47 INFO - PROCESS | 16656 | |7;imaging-desaturate;84;84;84;85;84;84;85;84;84;84 11:09:48 INFO - PROCESS | 16656 | |8;json-parse-financial;54;51;59;51;52;53;52;52;52;53 11:09:48 INFO - PROCESS | 16656 | |9;json-stringify-tinderbox;62;63;61;62;63;62;62;63;62;63 11:09:48 INFO - PROCESS | 16656 | |10;stanford-crypto-aes;88;85;80;80;79;79;79;80;79;80 11:09:48 INFO - PROCESS | 16656 | |11;stanford-crypto-ccm;142;130;131;131;138;128;131;127;185;138 11:09:48 INFO - PROCESS | 16656 | |12;stanford-crypto-pbkdf2;163;169;164;168;169;163;165;164;169;163 11:09:48 INFO - PROCESS | 16656 | |13;stanford-crypto-sha256-iterative;67;67;64;64;64;66;62;63;64;66 11:09:48 INFO - PROCESS | 16656 | __end_tp_report 11:09:48 INFO - PROCESS | 16656 | __start_cc_report 11:09:48 INFO - PROCESS | 16656 | _x_x_mozilla_cycle_collect,1694 11:09:48 INFO - PROCESS | 16656 | __end_cc_report 11:09:48 INFO - PROCESS | 16656 | __startTimestamp1478632187991__endTimestamp 11:09:48 INFO - PROCESS | 16656 | 11:09:48 INFO - PROCESS | 16656 | ------- Summary: start ------- 11:09:48 INFO - PROCESS | 16656 | Number of tests: 14 11:09:48 INFO - PROCESS | 16656 | 11:09:48 INFO - PROCESS | 16656 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.50 stddev:2.56 (2.3%) stddev-sans-first:0.87 11:09:48 INFO - PROCESS | 16656 | Values: 105.0 112.0 114.0 113.0 114.0 112.0 112.0 112.0 112.0 113.0 11:09:48 INFO - PROCESS | 16656 | 11:09:48 INFO - PROCESS | 16656 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:126.50 stddev:16.84 (13.3%) stddev-sans-first:16.15 11:09:48 INFO - PROCESS | 16656 | Values: 155.0 127.0 121.0 159.0 126.0 125.0 123.0 123.0 162.0 124.0 11:09:48 INFO - PROCESS | 16656 | 11:09:48 INFO - PROCESS | 16656 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 11:09:48 INFO - PROCESS | 16656 | Values: 162.0 161.0 161.0 163.0 161.0 162.0 163.0 162.0 161.0 160.0 11:09:48 INFO - PROCESS | 16656 | 11:09:48 INFO - PROCESS | 16656 | [#3] audio-fft Cycles:10 Average:80.60 Median:76.00 stddev:10.50 (13.8%) stddev-sans-first:10.94 11:09:48 INFO - PROCESS | 16656 | Values: 75.0 76.0 76.0 100.0 76.0 76.0 76.0 75.0 101.0 75.0 11:09:48 INFO - PROCESS | 16656 | 11:09:48 INFO - PROCESS | 16656 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:82.00 stddev:14.11 (17.2%) stddev-sans-first:14.61 11:09:48 INFO - PROCESS | 16656 | Values: 82.0 82.0 117.0 83.0 82.0 82.0 101.0 82.0 83.0 113.0 11:09:48 INFO - PROCESS | 16656 | 11:09:48 INFO - PROCESS | 16656 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:09:48 INFO - PROCESS | 16656 | Values: 116.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 11:09:48 INFO - PROCESS | 16656 | 11:09:48 INFO - PROCESS | 16656 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 11:09:48 INFO - PROCESS | 16656 | Values: 146.0 146.0 145.0 147.0 145.0 145.0 145.0 147.0 145.0 145.0 11:09:48 INFO - PROCESS | 16656 | 11:09:48 INFO - PROCESS | 16656 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 11:09:48 INFO - PROCESS | 16656 | Values: 84.0 84.0 84.0 85.0 84.0 84.0 85.0 84.0 84.0 84.0 11:09:48 INFO - PROCESS | 16656 | 11:09:48 INFO - PROCESS | 16656 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:52.50 stddev:2.33 (4.4%) stddev-sans-first:2.44 11:09:48 INFO - PROCESS | 16656 | Values: 54.0 51.0 59.0 51.0 52.0 53.0 52.0 52.0 52.0 53.0 11:09:48 INFO - PROCESS | 16656 | 11:09:48 INFO - PROCESS | 16656 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 11:09:48 INFO - PROCESS | 16656 | Values: 62.0 63.0 61.0 62.0 63.0 62.0 62.0 63.0 62.0 63.0 11:09:48 INFO - PROCESS | 16656 | 11:09:48 INFO - PROCESS | 16656 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.00 stddev:3.07 (3.8%) stddev-sans-first:1.90 11:09:48 INFO - PROCESS | 16656 | Values: 88.0 85.0 80.0 80.0 79.0 79.0 79.0 80.0 79.0 80.0 11:09:48 INFO - PROCESS | 16656 | 11:09:48 INFO - PROCESS | 16656 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:134.50 stddev:17.18 (12.8%) stddev-sans-first:18.17 11:09:48 INFO - PROCESS | 16656 | Values: 142.0 130.0 131.0 131.0 138.0 128.0 131.0 127.0 185.0 138.0 11:09:48 INFO - PROCESS | 16656 | 11:09:48 INFO - PROCESS | 16656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:166.50 stddev:2.71 (1.6%) stddev-sans-first:2.69 11:09:48 INFO - PROCESS | 16656 | Values: 163.0 169.0 164.0 168.0 169.0 163.0 165.0 164.0 169.0 163.0 11:09:48 INFO - PROCESS | 16656 | 11:09:48 INFO - PROCESS | 16656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.70 (2.6%) stddev-sans-first:1.59 11:09:48 INFO - PROCESS | 16656 | Values: 67.0 67.0 64.0 64.0 64.0 66.0 62.0 63.0 64.0 66.0 11:09:48 INFO - PROCESS | 16656 | -------- Summary: end -------- 11:09:48 INFO - PROCESS | 16656 | 11:09:49 INFO - TEST-INFO | 16656: exit 0 11:09:49 INFO - TEST-OK | kraken | took 61110ms 11:09:49 INFO - SUITE-END | took 1178s 11:09:49 INFO - Completed test suite (00:19:39) 11:09:49 INFO - javascript benchmark 11:09:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3078.615173103362, 3090.1502086926107, 3096.442640324742, 3110.331278775063, 3133.2323580722727, 5204.401493828211, 5231.0, 5290.232916227144, 5300.549453296465, 5313.973430132849, 5173.379194496666, 5244.082285600014, 5264.8157314494, 5314.202869569566, 5342.412334643196, 4734.810607575693, 4746.572808447239, 4789.712617242959, 4806.759662016902, 4812.254100614393, 4860.902781944359, 4894.143524883149, 4952.083864485082, 4955.281484184791, 4989.925151122736, 4752.572268495852, 4883.804647814083, 4897.094037603019, 4922.852314430573, 4997.925031124518, 4774.28385742138, 4803.087413391444, 4821.204501257288, 4828.49300823412, 4843.709377437365, 4780.521947805227, 4836.51634836517, 4868.707877527359, 4871.8294859679745, 4882.877928051827, 5308.309919710413, 5308.9469105308835, 5310.468953104659, 5323.148296272578, 5328.413874473805, 5430.56555475565, 5463.180522921554, 5611.410801865786, 5619.129034999582, 5624.437556244384, 5590.24531688225, 5640.633358831663, 5641.943580564182, 5677.460641239076, 5702.7433765480655, 5256.316678831728, 5259.263703081571, 5261.631685781997, 5265.947340526584, 5266.7629956652045, 5445.319335083114, 5758.395368486249, 5765.048766953406, 5777.24895763548, 5817.127430885316, 5378.220158077057, 5460.972695136499, 5493.176023596492, 5497.312835895513, 5526.861828454321, 5562.9443705563235, 5584.357798853102, 5600.719964001783, 5676.403977582377, 5677.602567820296, 5657.886842263131, 5670.489655930986, 5672.943270567324, 5675.120356344773, 5675.943240567624, 5453.400125986138, 5471.179323101566, 5585.106382978785, 5610.933922554702, 5619.438056194348, 4360.4767427908855, 4362.563743625676, 4385.210662080793, 4394.231009573312, 4456.064226512404, 3844.3656796628243, 3883.805809709503, 3930.4693866328253, 3940.2119576084897, 4002.779847108379, 5332.520073193431, 5365.0, 5398.163284690879, 5398.64908780928, 5423.593230507728, 5636.802711905064, 5706.9429305707245, 5714.685692286964, 5751.568632352591, 5757.280339957505, 5405.270288511079, 5416.702081385482, 5417.26866872975, 5443.891122177534, 5444.346678398539, 4864.80540778372, 4919.0, 4923.076923076923, 4954.950450495521, 5014.2979982802435, 5844.620099693507, 5888.852778680567, 5908.350081491032, 5947.434993675594, 5993.880122397441, 5683.2895888014, 5685.374608793112, 5691.8861622768145, 5695.117256825199, 5696.886062278649, 5583.330000399978, 5876.500497457593, 5932.5550583705535, 5939.168516407793, 5941.465268125889, 5325.627206095691, 5465.508104270476, 5468.234447177478, 5488.69812160335, 5592.888142237051, 5632.070708333079, 5649.4633009864, 5649.519790817826, 5651.915221271602, 5654.15187721845, 5501.724913754216, 5523.309586301712, 5525.889482210253, 5526.300041888557, 5533.889322213614, 5325.09473389517, 5370.087085195604, 5460.31746031746, 5479.643823151482, 5488.588355873246, 5469.316335458067, 5512.6692398456225, 5516.724163791714, 5522.5858060646415, 5553.72231388437, 5424.7558859850615, 5436.238926550365, 5552.083906155601, 5585.357683866408, 5589.329280486368, 5411.053065713406, 5424.186372044225, 5427.701476418835, 5442.183672449164, 5513.173024046425], "value": 5219.527010092094, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.8724296942219, 586.563010557135, 603.6438501284241, 620.4694985787155, 645.5255387290338, 31990.520142197856, 41842.79078604606, 42979.78510107453, 42999.3550096748, 43002.784986075065, 44210.33684494735, 44443.555564444345, 44507.77746111265, 44593.55406445934, 44607.0, 7602.771916842476, 8676.089010653885, 8822.64709411626, 8829.779255518599, 8832.558372081403, 7901.565413902233, 8143.0, 8150.429469937107, 10104.595816167344, 10377.792444151113, 10466.790664186712, 10523.315984460985, 10523.78952420955, 10529.684109476728, 10531.21015923805, 10395.16838652906, 10492.160627149886, 10504.264701470938, 10531.84202236967, 10541.84187237192, 10204.642837500725, 10397.636082737068, 10400.947995259976, 10402.843957340647, 10404.531796069195, 40305.0, 40628.59371406307, 40673.79663101665, 40682.0, 40731.7963410184, 3235.7573182011206, 3263.209053669377, 3311.9006429807146, 3347.7991320520846, 3392.7625066245373, 30522.38955220883, 30718.232044199074, 30776.53835192474, 30789.538156927665, 31895.0, 4022.0, 4114.465119534471, 4146.771927543984, 4162.771047592381, 4234.640055595247, 334397.0, 334443.0, 334721.0, 335726.0, 336686.0, 33843.66156338454, 35184.64815351865, 55606.0, 55928.0, 55956.0, 36214.0, 36279.63720362762, 36503.817480912425, 36504.63495365012, 36552.0, 15478.9226053869, 15503.922480387751, 15514.146721930401, 15639.68720625581, 15641.68716625684, 11558.133140014532, 13032.934835325763, 13125.409356578786, 13127.277999709917, 13133.868661313456, 8154.2253485918745, 8301.418900677016, 8598.613062412207, 8604.827903441896, 8669.306455483546, 3312.0601867934492, 3318.767686261987, 3331.983340083284, 3366.4613661814483, 3390.135515443546, 914.3645166609143, 1021.8569400283966, 1026.7638443158116, 1070.9344202518544, 1072.7157303314627, 31152.22119447032, 31327.843360783507, 31442.842785786383, 31751.0, 32230.19424514406, 1095.9726006849892, 1117.9385133817718, 1130.4573804573686, 1135.2677522997785, 1198.532572296805, 16479.76401769872, 16508.17459127039, 16568.83431165697, 16590.83409165893, 16968.40610578624, 529768.0, 532808.0, 533834.0, 535061.0, 536264.0, 55919.16121258184, 56937.43062569321, 57012.00915935927, 57171.71414142902, 61701.0, 1261.1235191541973, 1298.480607756886, 1361.4894414594528, 1369.2400717601627, 1401.4884567132924, 28978.56532151977, 32099.358012839144, 32531.51202732008, 33941.83029084839, 34058.65941340555, 53468.73265633647, 54290.0, 54357.45642543682, 54424.0, 54500.0, 418895.0, 422317.0, 422683.0, 426166.0, 428191.0, 24871.50256994886, 25397.0, 28152.85923570369, 28382.574261385682, 36119.63880361268, 38339.42490862695, 39871.0, 40399.0, 41403.0, 48143.75928120477, 37609.623903761705, 40237.0, 40293.0, 41172.0, 41206.0, 40207.396889046104, 40513.79743101266, 40961.0, 41628.58371416368, 42430.36354454747, 40534.39198412085, 40907.1818563633, 41721.16557668769, 41730.58269417267, 42335.7883210582, 32637.836810815796, 36793.26413471662, 37047.25905481821, 37533.62466375301, 37668.81165594154, 28246.576301355086, 28411.857940710164, 28425.0, 28455.28861778472, 28544.57183142296], "value": 18863.212041221348, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.1702715783278, 398.45411785853383, 401.7328476563086, 404.7328763016409, 420.92243855729333, 13867.930660346708, 16699.0, 17538.29846806128, 19453.70819437708, 19504.804951950493, 14440.783388249185, 14878.181700006495, 17102.144892755376, 17383.73924391135, 17738.29046838128, 5153.30430391897, 5557.3331200256025, 5588.86027849303, 5590.608657393984, 5595.132754423071, 5533.944660553403, 5575.69333686647, 5625.971870140644, 5635.070213414781, 5636.041872881599, 5438.320209973754, 5562.360328562207, 5593.496585307322, 5597.74810133545, 5604.663720176782, 5279.736013199363, 5558.888822223553, 5584.91622625661, 5605.551555875561, 5624.0439125348585, 5430.208031349645, 5534.667919924817, 5539.473749993744, 5553.4724201200825, 5554.361248456398, 13741.519046833313, 14340.64148396288, 21990.120395184174, 22175.556488870134, 22229.888850555806, 2312.8034117100065, 2341.94145146371, 2377.9286621401384, 2383.416063064543, 2576.6220376034016, 10574.735631609194, 10927.617533386294, 11838.052955763604, 13618.727625447535, 13862.514811981533, 1813.9727904081449, 1822.325739476389, 1836.0079313944386, 1849.3157531713218, 1884.9717254241198, 69320.0, 82094.58952705198, 85459.57270213672, 86336.0, 90543.09456905413, 10954.178436617127, 11017.173711971634, 11285.557904838939, 11290.717732056764, 11362.204645674889, 15675.921620391826, 15891.523254302389, 15905.0, 15913.124778137313, 15917.124558149413, 6912.619805910723, 7285.4171666266575, 7743.303102720783, 7761.262680045386, 8024.157463466368, 7830.216978302238, 7849.568273744884, 7854.136045035041, 8073.9192608074345, 8100.8379832403025, 4660.953390466119, 4756.453007904066, 4829.879253018703, 4884.3161957326, 4926.581240594518, 1771.8097564963864, 1869.6073824496737, 1951.5218771401098, 2009.1260301768777, 2064.8554601177775, 869.5304535550858, 915.6154415145655, 993.9652112176184, 1060.9045185933303, 1064.7338165458636, 18321.267149313877, 18618.348357807412, 18757.77949961248, 18837.43487695344, 19406.2237510498, 964.6430820596424, 969.9321047526605, 975.1564896364594, 988.6935050134481, 1031.742064483879, 10042.246831487668, 10454.947725261325, 10561.735956600993, 10593.152547796159, 10605.204609654307, 327412.0, 328117.0, 331377.0, 435267.0, 472007.0, 68920.0, 94378.5281073604, 95900.52049739707, 95984.0, 97462.0, 997.7156510394502, 1018.3431686562274, 1041.6302212714377, 1057.3444464431948, 1059.2003037706481, 15976.840231597535, 15977.81829990286, 16094.67810643804, 17206.82793172102, 17278.568035798704, 39488.40767388434, 39899.800500997306, 39906.201875961735, 40413.393799092446, 41062.0, 55237.72381138069, 55328.44671553233, 55560.0, 56401.0, 57540.1368979474, 6515.153030106056, 7017.333353331425, 7170.139583250043, 7217.963910180415, 7564.163438710483, 9552.42685438876, 10707.143428525855, 10928.508217130408, 10942.507587158438, 11097.38964356968, 9419.481928493999, 9727.221822254343, 10031.29780915329, 10064.144547713526, 10072.726363931604, 9322.580483878377, 9811.656592019244, 9833.901660983298, 9983.90177080535, 10008.0, 9731.708048758548, 9801.50992450389, 9880.604775808888, 10220.488975551341, 10421.709899126983, 6423.197100362455, 6821.590704557742, 7087.114110736158, 7307.0, 7458.888116678146, 8590.78523036929, 9706.0, 9802.558884850341, 10065.69802905914, 10240.48797560134], "value": 8684.07558908972, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1423.1958943197094, 1467.603746988313, 1560.3290585048433, 1698.7366958121495, 1709.2564734340563, 7792.220777922212, 8372.41393102483, 8378.790530236733, 8382.413231073828, 8383.413161078726, 7186.964065179667, 7376.926230737691, 7814.843703125934, 7988.520688758678, 8227.67089316428, 2221.0449506712107, 2251.583457060449, 2251.966220506694, 2253.9436514087197, 2256.0975609756065, 2234.575430668176, 2264.320703788865, 2303.101790301775, 2304.700388949434, 2305.8385912986096, 1931.3240365871902, 2000.5098750806073, 2002.839772818171, 2013.6979453082008, 2149.570085982802, 2174.08688350893, 2194.0455901682817, 2207.128184367182, 2208.083645287204, 2211.292386436341, 2231.1187081102876, 2256.785605367504, 2264.8754318512474, 2291.9885400573057, 2298.333483289844, 8200.671973121069, 8207.343412526983, 8270.958645206736, 8290.336773058201, 8310.501369917763, 4999.675021123615, 5139.203423469331, 5140.460251673595, 5144.43411224765, 5153.458886816905, 3107.64262109858, 3290.177455636091, 3325.1022223999385, 3349.698527132545, 3368.4105281575626, 1113.4766659669942, 1141.2125633312987, 1192.1893112683372, 1201.7656556971394, 1211.9697007574794, 11265.127392514938, 11272.887271127347, 11274.605388811435, 11332.830007549894, 11357.659270221906, 4275.593818587229, 4419.558044195554, 4472.2620767573635, 4518.615917647036, 4525.796339164745, 9560.187384072431, 9562.378445401027, 9565.186959108414, 9570.665026724031, 9570.712878613653, 5070.7464626768515, 5072.087024335655, 5073.34046573943, 5073.695578265316, 5077.695338279715, 4474.798634061475, 4638.95361046392, 4676.929846052312, 4682.5015994882, 4685.344051832746, 3738.9626103738615, 3739.0, 3774.6225377462033, 3825.3305671507374, 3829.7893615851394, 1272.2239433945285, 1282.9807552886714, 1284.3770771175973, 1291.1671971578467, 1314.0932756398247, 867.5878957495265, 879.9164079412445, 894.4409743910056, 924.7872989212519, 935.6912218967724, 5250.396204436539, 5408.810691625853, 5460.5085542301385, 5473.75368108436, 5500.6424582402815, 937.3906960475746, 939.7133874168308, 960.2845879819579, 963.710886733977, 978.8042391521724, 3556.982215088908, 3696.722745794076, 3730.813459327023, 3825.617438256152, 3843.942340864889, 10060.446675432922, 10179.389236645826, 10303.124234440156, 10338.896611033944, 10387.792244155225, 9553.426794392359, 10166.745831354126, 10198.490075496196, 10208.948955255177, 10218.489075546193, 7489.550626962399, 7828.608569571613, 7844.294013538809, 7844.529328240324, 7853.842923141505, 5478.671279723229, 5574.470425309752, 5610.354809196831, 5689.2319536862, 5754.395788442153, 8923.509206993418, 9159.038300978302, 9185.494797786187, 9489.952550237205, 9496.667616633385, 9276.582553784961, 9417.293702972442, 9478.57346419399, 9559.426434413957, 9579.036297559123, 7020.508564400443, 7055.61194134307, 7141.392981596622, 7181.425485961215, 7210.134783825974, 7495.587742674205, 7556.962215188889, 7563.394928405824, 7563.432742544222, 7563.546187228784, 5562.749676264497, 6852.862942741018, 6977.1278590176225, 6983.057287266357, 7098.25468325839, 6676.732930682719, 6792.558483698544, 6826.419754320938, 6854.588724676535, 6932.549384290005, 6120.846978825565, 6278.277998030285, 6330.240371155491, 6330.8100756977365, 6331.0819931110655, 4726.550977657117, 4767.118083154627, 4780.904381912412, 4865.610751139971, 4948.826791062295, 4750.5249475052215, 4776.0, 4830.637702172281, 4832.758362081952, 4889.095517329305], "value": 4370.089584832099, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.3011310625601, 334.620206066115, 337.4297437330909, 337.5021842781897, 342.95884493860734, 5067.680669161696, 5197.0, 5238.895222095561, 5260.973695131529, 5271.367435907691, 4999.97500512395, 5071.137906555885, 5156.407013193484, 5165.974170129153, 5175.378954525453, 4116.650084742801, 4118.773467459296, 4128.174365126986, 4130.628243458088, 4138.33786594145, 4012.277789997799, 4070.124923141524, 4134.346261495396, 4144.171165766844, 4145.523264824538, 4041.4139949707273, 4059.4722686050773, 4061.6344528992386, 4067.430559721641, 4069.9186016279805, 4043.97978010111, 4052.9797351013353, 4053.716239863211, 4077.8572749953905, 4078.714489985702, 3616.2405894762132, 3616.801075940822, 3617.9095522611883, 3622.7826330420257, 3623.2572322673786, 4973.303737476756, 5047.520485553867, 5069.822556210515, 5071.695698258116, 5076.111680455942, 4626.0, 4634.559716826896, 4654.976725116387, 4655.4180727409075, 4658.790354434024, 5424.833660762955, 5426.240326354314, 5434.945650543484, 5458.208559758813, 5467.753951072212, 3852.3451013327804, 3927.3519869221545, 3938.9015274618077, 3958.960410395888, 3963.564007959122, 5642.858928526779, 5656.0, 5665.688387138705, 5669.688167150846, 5671.688057156814, 4021.678265738734, 4023.973886658883, 4025.6587032762736, 4026.4362989181536, 4031.7422243543124, 3970.2059588082498, 4023.3964905264443, 4050.311447054008, 4051.6758659307184, 4071.206114807584, 4626.553217852721, 4627.398438203079, 4638.768061596907, 4644.233701439292, 4653.139169253631, 5505.229267902497, 5508.20131080999, 5518.44815518453, 5523.171524271311, 5524.502794748492, 1262.722201115753, 1295.0028478071831, 1334.9332533373292, 1335.3723749837561, 1349.6907999240916, 924.9583768730423, 928.4893308680199, 953.7377221264207, 956.1776871890307, 960.9423434593947, 5131.948680513147, 5136.255242989746, 5137.9743101285, 5143.742812859342, 5153.500552232164, 5376.494581517181, 5379.515843574097, 5400.459954004568, 5408.4050754416985, 5409.754951695081, 4817.867801066746, 5101.194343111274, 5142.614303927146, 5146.536811686966, 5146.588272938231, 2789.302674331417, 2819.4502072096157, 2825.27955371379, 2829.5331270340575, 2836.950328378472, 5524.226608274845, 5525.226468294361, 5529.917051244234, 5555.916661250004, 5560.555155587544, 5206.349206349207, 5392.203381365049, 5415.296011518478, 5431.429699881534, 5452.427495113036, 5528.944710552843, 5552.861178470571, 5556.777508948025, 5557.638753481092, 5589.189567512769, 5179.1355112160345, 5313.415524292402, 5322.498425739896, 5325.227841962971, 5370.409254981871, 5266.447023062523, 5273.44628813969, 5275.973620131875, 5283.418823929442, 5320.494553017457, 5495.038368285614, 5519.2824932758485, 5524.768010713617, 5528.226048353315, 5535.833924982257, 3685.207680348738, 3854.730168888263, 3864.8260828262232, 3879.3512757077565, 3905.258000979805, 5239.764210610608, 5253.23828044939, 5256.237845512455, 5264.842054738364, 5271.551918087006, 5305.814296499604, 5378.462153784747, 5410.07942180536, 5418.295621569171, 5440.7551660174595, 5385.353757549119, 5387.218853266333, 5399.757010934596, 5417.485338892799, 5417.566594672496, 5258.817590699817, 5377.408485066718, 5385.676859388449, 5402.243685883901, 5419.0, 5418.322709661293, 5432.940576587527, 5457.0, 5457.5633949283165, 5474.835754927359, 5330.573554115584, 5338.145896656516, 5340.145576707863, 5343.4389389113585, 5346.304980352529], "value": 4108.328869298708, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.7671791590861, 687.281790528897, 702.7961891051596, 729.18331468755, 750.834816340405, 12914.225146491206, 13325.533606323781, 13339.599812005632, 13627.523036693718, 14266.215358155298, 14629.707405851903, 14758.40966361347, 14772.0, 14836.925815370909, 14845.406183752664, 657.0374401501799, 775.2789905387987, 792.7582087463321, 794.2216627704853, 796.2873228460525, 673.5924765516866, 763.7517806712813, 787.6140691061368, 795.5147360110328, 795.5306369242146, 825.5129473610568, 827.548985802736, 828.1925123005052, 833.7082021292559, 834.5034704350901, 695.7147569496482, 830.1242189490085, 830.1988581019345, 830.3564737328559, 830.6718846055774, 524.6825670469387, 586.1500823805499, 606.0364021206259, 609.0133982947609, 610.0757352610798, 12890.87109128906, 12904.22574645515, 12924.224546527144, 12944.288064156468, 12944.546940857119, 10962.177836662202, 11044.392558409285, 11279.774404511863, 12629.557965471164, 13230.603081907559, 10355.637552685619, 10459.320144190679, 10464.21518386124, 10517.894821051768, 10910.399928003957, 3587.3542762302777, 3601.45978103284, 3648.21563363878, 3764.416515440111, 3764.4729737836724, 52970.735146324405, 56388.71805640987, 56502.0, 64603.35396646067, 65028.67485662589, 9880.950595246977, 9888.357256778287, 9945.80108397828, 9952.601895924226, 10090.192784577217, 17405.912970435067, 17532.386366477112, 17563.121843907753, 17569.648607027786, 17577.560560986076, 7209.927900721031, 7424.109106907205, 7807.570583617842, 7863.488873223222, 7883.487573307717, 4342.609165175149, 4467.218236808546, 4490.663200259994, 4681.157391669464, 4695.272232803921, 3321.817300048472, 3412.232247744287, 3448.7412094585798, 3448.758586898893, 3451.447768357051, 614.9016157414792, 616.3528295289927, 617.3826173826174, 636.462189449914, 644.2462319086679, 565.2369301443019, 568.5707290995272, 582.7989343676425, 661.3254480429935, 664.8138521214067, 8208.343332533503, 8259.876101858477, 8476.830463390697, 8570.614322355508, 8880.0, 611.2847967877594, 612.9724162412703, 693.7606525748608, 699.951003429755, 711.0862541633976, 3839.0786211309087, 4003.959960400417, 4039.4748682671066, 4062.5734297898293, 4094.570070142592, 87936.0, 88046.55976720076, 88844.5557772207, 89979.55010224906, 90077.54961225152, 49781.75109124431, 50985.49014509882, 59256.11115833266, 67806.66096669485, 76119.0, 68846.311536884, 71400.0, 71646.0, 71658.64170679217, 72497.0, 7904.881426778718, 8190.754277371689, 8224.835503289782, 8240.175982401712, 8252.711155109542, 45892.77053614711, 46005.0, 46676.7666161667, 48622.75688621534, 49991.50008499868, 46682.0, 48888.75555622199, 57867.42132578789, 58223.41776582349, 63333.366666332746, 10131.949340253252, 10153.39079655223, 10434.06093451593, 11082.335059896432, 11649.184557080924, 12283.75432491363, 12352.320622365856, 12430.067744919348, 12627.0, 12823.422945967268, 11722.472488738198, 11782.587609433629, 11838.289702617525, 12269.386530673251, 12607.49570017189, 11184.94407527957, 11471.139664525028, 11865.288082715064, 11917.404129793302, 11922.701932451759, 11952.58165964187, 12066.276023438622, 12128.696782580506, 12352.25886446816, 12947.935260323638, 8845.292376609985, 9008.099190080939, 9212.723618291462, 9318.0, 9445.0, 9293.117153870371, 9523.142917137491, 9689.70930872075, 9830.852537212091, 9854.458004809518], "value": 6611.744201549602, "unit": "score"}], "name": "dromaeo_css", "value": 6829.90362685307, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 114.0, 113.0, 114.0, 112.0, 112.0, 112.0, 112.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 121.0, 159.0, 126.0, 125.0, 123.0, 123.0, 162.0, 124.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 163.0, 161.0, 162.0, 163.0, 162.0, 161.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 100.0, 76.0, 76.0, 76.0, 75.0, 101.0, 75.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 117.0, 83.0, 82.0, 82.0, 101.0, 82.0, 83.0, 113.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 147.0, 145.0, 145.0, 145.0, 147.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 59.0, 51.0, 52.0, 53.0, 52.0, 52.0, 52.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 80.0, 80.0, 79.0, 79.0, 79.0, 80.0, 79.0, 80.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 130.0, 131.0, 131.0, 138.0, 128.0, 131.0, 127.0, 185.0, 138.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 169.0, 164.0, 168.0, 169.0, 163.0, 165.0, 164.0, 169.0, 163.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 64.0, 64.0, 64.0, 66.0, 62.0, 63.0, 64.0, 66.0], "value": 64.7, "unit": "score"}], "name": "kraken", "value": 1490.2000000000003, "alertThreshold": 2.0}]} 11:09:49 INFO - Return code: 0 11:09:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:09:49 INFO - # TBPL SUCCESS # 11:09:49 INFO - Running post-action listener: _resource_record_post_action 11:09:49 INFO - [mozharness: 2016-11-08 19:09:49.304939Z] Finished run-tests step (success) 11:09:49 INFO - Running post-run listener: _resource_record_post_run 11:09:49 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403787776; Read time: 8; Write time: 258032 11:09:49 INFO - TinderboxPrint: CPU usage
13.1% 11:09:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:09:49 INFO - TinderboxPrint: I/O write bytes / time
403,787,776 / 258,032 11:09:49 INFO - TinderboxPrint: CPU idle
8,290.3 (86.9%) 11:09:49 INFO - TinderboxPrint: CPU user
1,202.6 (12.6%) 11:09:49 INFO - TinderboxPrint: Swap in / out
0 / 0 11:09:49 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114323456; Read time: 0; Write time: 63004 11:09:49 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288301056; Read time: 0; Write time: 195004 11:09:49 INFO - Running post-run listener: _upload_blobber_files 11:09:49 INFO - Blob upload gear active. 11:09:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:09:49 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 11:09:49 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'] 11:09:49 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 11:09:50 INFO - (blobuploader) - INFO - Open directory for files ... 11:09:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:09:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:09:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:09:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:09:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:09:51 INFO - (blobuploader) - INFO - Done attempting. 11:09:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:09:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:09:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:09:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:09:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:09:54 INFO - (blobuploader) - INFO - Done attempting. 11:09:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:09:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:09:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:09:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:09:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:09:55 INFO - (blobuploader) - INFO - Done attempting. 11:09:55 INFO - (blobuploader) - INFO - Iteration through files over. 11:09:55 INFO - Return code: 0 11:09:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:09:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:09:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36d4cce10d1f280f13a179ea6a1e1fbbca70f9758e49d113203e8cde48016a6129276377710ca55353a8feb1f95dd3a2910437894061310bec959aef8da1ad3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9418238f7b3d32243502c6c77e0874e3ce512bf63e8ea0becc26acc6ee821dfb7f1cc70a4e3dbb19c4a6a79b1fa49b9a3136d6e40881e0c6fafe401fc10b056", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa973a1482dac0f1dc4ab8c8d215aa54200e2611db9d399898745d9b46033189d83020edb45c813ed07f5830bd846a82bd92802370404daf9b8a3d830a179edd"} 11:09:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:09:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:09:55 INFO - Contents: 11:09:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36d4cce10d1f280f13a179ea6a1e1fbbca70f9758e49d113203e8cde48016a6129276377710ca55353a8feb1f95dd3a2910437894061310bec959aef8da1ad3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9418238f7b3d32243502c6c77e0874e3ce512bf63e8ea0becc26acc6ee821dfb7f1cc70a4e3dbb19c4a6a79b1fa49b9a3136d6e40881e0c6fafe401fc10b056", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa973a1482dac0f1dc4ab8c8d215aa54200e2611db9d399898745d9b46033189d83020edb45c813ed07f5830bd846a82bd92802370404daf9b8a3d830a179edd"} 11:09:55 INFO - Running post-run listener: copy_logs_to_upload_dir 11:09:55 INFO - Copying logs to upload dir... 11:09:55 INFO - mkdir: /builds/slave/test/build/upload/logs 11:09:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.599546 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-11-08 11:09:55.357641) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 11:09:55.361507) ========= 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=6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618 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/36d4cce10d1f280f13a179ea6a1e1fbbca70f9758e49d113203e8cde48016a6129276377710ca55353a8feb1f95dd3a2910437894061310bec959aef8da1ad3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9418238f7b3d32243502c6c77e0874e3ce512bf63e8ea0becc26acc6ee821dfb7f1cc70a4e3dbb19c4a6a79b1fa49b9a3136d6e40881e0c6fafe401fc10b056", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa973a1482dac0f1dc4ab8c8d215aa54200e2611db9d399898745d9b46033189d83020edb45c813ed07f5830bd846a82bd92802370404daf9b8a3d830a179edd"} build_url:https://queue.taskcluster.net/v1/task/EXLkjXmsRla-x_6RtV3kpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011505 build_url: 'https://queue.taskcluster.net/v1/task/EXLkjXmsRla-x_6RtV3kpw/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/36d4cce10d1f280f13a179ea6a1e1fbbca70f9758e49d113203e8cde48016a6129276377710ca55353a8feb1f95dd3a2910437894061310bec959aef8da1ad3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9418238f7b3d32243502c6c77e0874e3ce512bf63e8ea0becc26acc6ee821dfb7f1cc70a4e3dbb19c4a6a79b1fa49b9a3136d6e40881e0c6fafe401fc10b056", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa973a1482dac0f1dc4ab8c8d215aa54200e2611db9d399898745d9b46033189d83020edb45c813ed07f5830bd846a82bd92802370404daf9b8a3d830a179edd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 11:09:55.387295) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 11:09:55.387618) ========= 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=6dbc10da6d83fee962c624be000001a8-1478627745.921943-1435260618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 11:09:55.469946) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 11:09:55.470278) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 11:09:55.470557) ========= ========= Total master_lag: 0.16 =========