builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-089 starttime: 1487016830.05 results: success (0) buildid: 20170213102439 builduid: 7c3f002e147b483baec552ad471d2add revision: 4ad8573642c78523c549e9ee3b90c24f9a464834 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 12:13:50.052844) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 12:13:50.053277) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 12:13:50.053547) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 12:13:50.134026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 12:13:50.134382) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-13 12:13:50-- 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% 111M=0s 2017-02-13 12:13:50 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084021 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 12:13:50.231750) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 12:13:50.232052) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018571 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 12:13:50.280922) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-13 12:13:50.281278) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4ad8573642c78523c549e9ee3b90c24f9a464834 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4ad8573642c78523c549e9ee3b90c24f9a464834 --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=8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-13 12:13:51,023 truncating revision to first 12 chars 2017-02-13 12:13:51,023 Setting DEBUG logging. 2017-02-13 12:13:51,023 attempt 1/10 2017-02-13 12:13:51,023 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4ad8573642c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-13 12:13:52,435 unpacking tar archive at: mozilla-beta-4ad8573642c7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.809091 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-13 12:13:52.103549) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 12:13:52.103873) ========= script_repo_revision: 4ad8573642c78523c549e9ee3b90c24f9a464834 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 12:13:52.104302) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 12:13:52.104606) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 12:13:52.113514) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-02-13 12:13:52.113861) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:13:52 INFO - MultiFileLogger online at 20170213 12:13:52 in /builds/slave/test 12:13:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:13:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:13:52 INFO - {'append_to_log': False, 12:13:52 INFO - 'base_work_dir': '/builds/slave/test', 12:13:52 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:13:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:13:52 INFO - 'branch': 'Mozilla-Beta', 12:13:52 INFO - 'buildbot_json_path': 'buildprops.json', 12:13:52 INFO - 'config_files': ('talos/linux_config.py',), 12:13:52 INFO - 'default_actions': ('clobber', 12:13:52 INFO - 'read-buildbot-config', 12:13:52 INFO - 'download-and-extract', 12:13:52 INFO - 'populate-webroot', 12:13:52 INFO - 'create-virtualenv', 12:13:52 INFO - 'install', 12:13:52 INFO - 'run-tests'), 12:13:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:13:52 INFO - 'download_minidump_stackwalk': True, 12:13:52 INFO - 'download_symbols': 'ondemand', 12:13:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:13:52 INFO - 'tooltool.py': '/tools/tooltool.py', 12:13:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:13:52 INFO - '/tools/misc-python/virtualenv.py')}, 12:13:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:13:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:13:52 INFO - 'installer_path': 'installer.exe', 12:13:52 INFO - 'log_level': 'info', 12:13:52 INFO - 'log_name': 'talos', 12:13:52 INFO - 'log_to_console': True, 12:13:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:13:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:13:52 INFO - 'opt_config_files': (), 12:13:52 INFO - 'pip_index': False, 12:13:52 INFO - 'sps_profile': False, 12:13:52 INFO - 'sps_profile_interval': 0, 12:13:52 INFO - 'suite': 'dromaeojs', 12:13:52 INFO - 'system_bits': '32', 12:13:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:13:52 INFO - 'title': 'talos-linux64-ix-089', 12:13:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:13:52 INFO - 'use_talos_json': True, 12:13:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:13:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:13:52 INFO - 'work_dir': 'build'} 12:13:52 INFO - [mozharness: 2017-02-13 20:13:52.958886Z] Running clobber step. 12:13:52 INFO - Running pre-action listener: _resource_record_pre_action 12:13:52 INFO - Running main action method: clobber 12:13:52 INFO - rmtree: /builds/slave/test/build 12:13:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:13:53 INFO - Running post-action listener: _resource_record_post_action 12:13:53 INFO - [mozharness: 2017-02-13 20:13:53.882847Z] Finished clobber step (success) 12:13:53 INFO - [mozharness: 2017-02-13 20:13:53.882947Z] Running read-buildbot-config step. 12:13:53 INFO - Running pre-action listener: _resource_record_pre_action 12:13:53 INFO - Running main action method: read_buildbot_config 12:13:53 INFO - Using buildbot properties: 12:13:53 INFO - { 12:13:53 INFO - "project": "", 12:13:53 INFO - "product": "firefox", 12:13:53 INFO - "script_repo_revision": "production", 12:13:53 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 12:13:53 INFO - "repository": "", 12:13:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 12:13:53 INFO - "buildid": "20170213102439", 12:13:53 INFO - "pgo_build": "True", 12:13:53 INFO - "basedir": "/builds/slave/test", 12:13:53 INFO - "buildnumber": 15, 12:13:53 INFO - "slavename": "talos-linux64-ix-089", 12:13:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:13:53 INFO - "platform": "ubuntu64_hw", 12:13:53 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:13:53 INFO - "branch": "mozilla-beta", 12:13:53 INFO - "repo_path": "releases/mozilla-beta", 12:13:53 INFO - "revision": "4ad8573642c78523c549e9ee3b90c24f9a464834", 12:13:53 INFO - "stage_platform": "linux64-pgo", 12:13:53 INFO - "builduid": "7c3f002e147b483baec552ad471d2add", 12:13:53 INFO - "slavebuilddir": "test" 12:13:53 INFO - } 12:13:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 12:13:53 INFO - Running post-action listener: _resource_record_post_action 12:13:53 INFO - [mozharness: 2017-02-13 20:13:53.885381Z] Finished read-buildbot-config step (success) 12:13:53 INFO - [mozharness: 2017-02-13 20:13:53.885468Z] Running download-and-extract step. 12:13:53 INFO - Running pre-action listener: _resource_record_pre_action 12:13:53 INFO - Running main action method: download_and_extract 12:13:53 INFO - mkdir: /builds/slave/test/build/tests 12:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:13:53 INFO - trying https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 12:13:53 INFO - Downloading https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 12:13:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:13:54 INFO - Downloaded 1327 bytes. 12:13:54 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 12:13:54 INFO - Using the following test package requirements: 12:13:54 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 12:13:54 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:13:54 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:13:54 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:13:54 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 12:13:54 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:13:54 INFO - u'jsshell-linux-x86_64.zip'], 12:13:54 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:13:54 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:13:54 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 12:13:54 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:13:54 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 12:13:54 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:13:54 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 12:13:54 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:13:54 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:13:54 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:13:54 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:13:54 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:13:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 12:13:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:13:54 INFO - Fetch https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 12:13:55 INFO - Http code: 200 12:13:55 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 12:13:55 INFO - x-amz-cf-id: jGKQyWFLFdb0RdpOaOa-J4FyFCvjEGCvrqSF0Lpq9BY7V34NiAml0Q== 12:13:55 INFO - x-amz-version-id: pE7ayVDXj6UhZaFOu2HviGVV3ev8hnf_ 12:13:55 INFO - Expected file size: 21958848 12:13:55 INFO - Obtained file size: 21958848 12:13:59 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:13:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 12:13:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:13:59 INFO - Fetch https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 12:13:59 INFO - Http code: 200 12:13:59 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 12:13:59 INFO - x-amz-cf-id: 41IISh98ShoCOW6byqTrbep_1Y34aJwg2c_SJH5jwLb2AyRd6cqJWQ== 12:13:59 INFO - x-amz-version-id: pE7ayVDXj6UhZaFOu2HviGVV3ev8hnf_ 12:14:00 INFO - Expected file size: 21958848 12:14:00 INFO - Obtained file size: 21958848 12:14:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 12:14:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:14:04 INFO - Fetch https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 12:14:05 INFO - Http code: 200 12:14:05 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 12:14:05 INFO - x-amz-cf-id: x9PY1f6rxOG1pqNotigjL3drkd9d-7gH2yHzVizF6Nv1Eg5frvvnZA== 12:14:05 INFO - x-amz-version-id: hGTzwAz6DWH28cjzLk46fNegchjKoN0L 12:14:05 INFO - Expected file size: 14403005 12:14:05 INFO - Obtained file size: 14403005 12:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:05 INFO - trying https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:14:05 INFO - Downloading https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:14:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:14:06 INFO - Downloaded 57735572 bytes. 12:14:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:14:06 INFO - mkdir: /builds/slave/test/properties 12:14:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:14:06 INFO - Writing to file /builds/slave/test/properties/build_url 12:14:06 INFO - Contents: 12:14:06 INFO - build_url:https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:14:07 INFO - Running post-action listener: _resource_record_post_action 12:14:07 INFO - Running post-action listener: set_extra_try_arguments 12:14:07 INFO - [mozharness: 2017-02-13 20:14:07.391275Z] Finished download-and-extract step (success) 12:14:07 INFO - [mozharness: 2017-02-13 20:14:07.391503Z] Running populate-webroot step. 12:14:07 INFO - Running pre-action listener: _resource_record_pre_action 12:14:07 INFO - Running main action method: populate_webroot 12:14:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:14:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:14:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:14:07 INFO - '--tppagecycles', 12:14:07 INFO - '7'], 12:14:07 INFO - 'tests': ['tsvgm']}}, 12:14:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:14:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:14:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:14:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:14:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:14:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:14:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:07 INFO - 'talos_options': ['--disable-e10s'], 12:14:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:07 INFO - 'talos_options': ['--disable-e10s'], 12:14:07 INFO - 'tests': ['damp', 'tps']}, 12:14:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:07 INFO - 'tests': ['damp', 'tps']}, 12:14:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:14:07 INFO - 'tests': ['dromaeo_dom']}, 12:14:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:14:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:14:07 INFO - 'tests': ['basic_compositor_video']}, 12:14:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:14:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:14:07 INFO - 'tests': ['a11yr', 12:14:07 INFO - 'ts_paint', 12:14:07 INFO - 'tpaint', 12:14:07 INFO - 'sessionrestore', 12:14:07 INFO - 'sessionrestore_no_auto_restore', 12:14:07 INFO - 'tabpaint']}, 12:14:07 INFO - 'other-e10s': {'tests': ['a11yr', 12:14:07 INFO - 'ts_paint', 12:14:07 INFO - 'tpaint', 12:14:07 INFO - 'sessionrestore', 12:14:07 INFO - 'sessionrestore_no_auto_restore', 12:14:07 INFO - 'tabpaint']}, 12:14:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:14:07 INFO - 'ts_paint', 12:14:07 INFO - 'tpaint', 12:14:07 INFO - 'sessionrestore', 12:14:07 INFO - 'sessionrestore_no_auto_restore', 12:14:07 INFO - 'tabpaint']}, 12:14:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:14:07 INFO - 'ts_paint', 12:14:07 INFO - 'tpaint', 12:14:07 INFO - 'sessionrestore', 12:14:07 INFO - 'sessionrestore_no_auto_restore', 12:14:07 INFO - 'tabpaint']}, 12:14:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:14:07 INFO - 'tests': ['a11yr', 12:14:07 INFO - 'ts_paint', 12:14:07 INFO - 'tpaint', 12:14:07 INFO - 'sessionrestore', 12:14:07 INFO - 'sessionrestore_no_auto_restore', 12:14:07 INFO - 'tabpaint']}, 12:14:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:14:07 INFO - 'tests': ['a11yr', 12:14:07 INFO - 'ts_paint', 12:14:07 INFO - 'tpaint', 12:14:07 INFO - 'sessionrestore', 12:14:07 INFO - 'sessionrestore_no_auto_restore', 12:14:07 INFO - 'tabpaint']}, 12:14:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:14:07 INFO - 'tests': ['tsvgx', 12:14:07 INFO - 'tsvgr_opacity', 12:14:07 INFO - 'tart', 12:14:07 INFO - 'tscrollx', 12:14:07 INFO - 'cart']}, 12:14:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:14:07 INFO - 'tsvgr_opacity', 12:14:07 INFO - 'tart', 12:14:07 INFO - 'tscrollx', 12:14:07 INFO - 'cart']}, 12:14:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:07 INFO - 'talos_options': ['--disable-e10s'], 12:14:07 INFO - 'tests': ['tp5o']}, 12:14:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:07 INFO - 'tests': ['tp5o']}, 12:14:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:07 INFO - 'talos_options': ['--disable-e10s', 12:14:07 INFO - '--xperf_path', 12:14:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:07 INFO - 'tests': ['tp5n']}, 12:14:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:07 INFO - 'talos_options': ['--xperf_path', 12:14:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:07 INFO - 'tests': ['tp5n']}}, 12:14:07 INFO - 'talos.zip': {'path': '', 12:14:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:14:07 INFO - Running post-action listener: _resource_record_post_action 12:14:07 INFO - [mozharness: 2017-02-13 20:14:07.412457Z] Finished populate-webroot step (success) 12:14:07 INFO - [mozharness: 2017-02-13 20:14:07.412545Z] Running create-virtualenv step. 12:14:07 INFO - Running pre-action listener: _resource_record_pre_action 12:14:07 INFO - Running main action method: create_virtualenv 12:14:07 INFO - Creating virtualenv /builds/slave/test/build/venv 12:14:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:14:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:14:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:14:07 INFO - Using real prefix '/usr' 12:14:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:14:08 INFO - Installing distribute.............................................................................................................................................................................................done. 12:14:09 INFO - Installing pip.................done. 12:14:09 INFO - Return code: 0 12:14:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:14:10 INFO - Reading from file tmpfile_stdout 12:14:10 INFO - Output received: 12:14:10 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:14:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:14:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:10 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 0x7f8110b6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18adca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aaf60>, '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 0x18abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ac1d0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:14:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:14:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:14:10 INFO - Using env: {'DISPLAY': ':0', 12:14:10 INFO - 'HOME': '/home/cltbld', 12:14:10 INFO - 'LANG': 'en_US.UTF-8', 12:14:10 INFO - 'LANGUAGE': 'en_US:en', 12:14:10 INFO - 'LOGNAME': 'cltbld', 12:14:10 INFO - 'MAIL': '/var/mail/cltbld', 12:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:10 INFO - 'MOZ_NO_REMOTE': '1', 12:14:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:10 INFO - 'NO_EM_RESTART': '1', 12:14:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:10 INFO - 'PWD': '/builds/slave/test', 12:14:10 INFO - 'SHELL': '/bin/bash', 12:14:10 INFO - 'SHLVL': '1', 12:14:10 INFO - 'TERM': 'linux', 12:14:10 INFO - 'TMOUT': '86400', 12:14:10 INFO - 'USER': 'cltbld', 12:14:10 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706', 12:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:10 INFO - '_': '/tools/buildbot/bin/python'} 12:14:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:14:10 INFO - Cleaning up... 12:14:10 INFO - Return code: 0 12:14:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:14:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:10 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 0x7f8110b6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18adca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aaf60>, '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 0x18abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ac1d0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:14:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:14:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:14:10 INFO - Using env: {'DISPLAY': ':0', 12:14:10 INFO - 'HOME': '/home/cltbld', 12:14:10 INFO - 'LANG': 'en_US.UTF-8', 12:14:10 INFO - 'LANGUAGE': 'en_US:en', 12:14:10 INFO - 'LOGNAME': 'cltbld', 12:14:10 INFO - 'MAIL': '/var/mail/cltbld', 12:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:10 INFO - 'MOZ_NO_REMOTE': '1', 12:14:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:10 INFO - 'NO_EM_RESTART': '1', 12:14:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:10 INFO - 'PWD': '/builds/slave/test', 12:14:10 INFO - 'SHELL': '/bin/bash', 12:14:10 INFO - 'SHLVL': '1', 12:14:10 INFO - 'TERM': 'linux', 12:14:10 INFO - 'TMOUT': '86400', 12:14:10 INFO - 'USER': 'cltbld', 12:14:10 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706', 12:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:10 INFO - '_': '/tools/buildbot/bin/python'} 12:14:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:10 INFO - Downloading/unpacking psutil>=3.1.1 12:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:14:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:12 INFO - Installing collected packages: psutil 12:14:12 INFO - Running setup.py install for psutil 12:14:12 INFO - building 'psutil._psutil_linux' extension 12:14:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:14:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:14:13 INFO - building 'psutil._psutil_posix' extension 12:14:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:14:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:14:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:13 INFO - Successfully installed psutil 12:14:13 INFO - Cleaning up... 12:14:13 INFO - Return code: 0 12:14:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:13 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 0x7f8110b6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18adca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aaf60>, '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 0x18abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ac1d0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:14:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:14:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:14:13 INFO - Using env: {'DISPLAY': ':0', 12:14:13 INFO - 'HOME': '/home/cltbld', 12:14:13 INFO - 'LANG': 'en_US.UTF-8', 12:14:13 INFO - 'LANGUAGE': 'en_US:en', 12:14:13 INFO - 'LOGNAME': 'cltbld', 12:14:13 INFO - 'MAIL': '/var/mail/cltbld', 12:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:13 INFO - 'MOZ_NO_REMOTE': '1', 12:14:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:13 INFO - 'NO_EM_RESTART': '1', 12:14:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:13 INFO - 'PWD': '/builds/slave/test', 12:14:13 INFO - 'SHELL': '/bin/bash', 12:14:13 INFO - 'SHLVL': '1', 12:14:13 INFO - 'TERM': 'linux', 12:14:13 INFO - 'TMOUT': '86400', 12:14:13 INFO - 'USER': 'cltbld', 12:14:13 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706', 12:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:13 INFO - '_': '/tools/buildbot/bin/python'} 12:14:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:14:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:14:15 INFO - Installing collected packages: mozsystemmonitor 12:14:15 INFO - Running setup.py install for mozsystemmonitor 12:14:15 INFO - Successfully installed mozsystemmonitor 12:14:15 INFO - Cleaning up... 12:14:15 INFO - Return code: 0 12:14:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8110b6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18adca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aaf60>, '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 0x18abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ac1d0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:14:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:14:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:14:15 INFO - Using env: {'DISPLAY': ':0', 12:14:15 INFO - 'HOME': '/home/cltbld', 12:14:15 INFO - 'LANG': 'en_US.UTF-8', 12:14:15 INFO - 'LANGUAGE': 'en_US:en', 12:14:15 INFO - 'LOGNAME': 'cltbld', 12:14:15 INFO - 'MAIL': '/var/mail/cltbld', 12:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:15 INFO - 'MOZ_NO_REMOTE': '1', 12:14:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:15 INFO - 'NO_EM_RESTART': '1', 12:14:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:15 INFO - 'PWD': '/builds/slave/test', 12:14:15 INFO - 'SHELL': '/bin/bash', 12:14:15 INFO - 'SHLVL': '1', 12:14:15 INFO - 'TERM': 'linux', 12:14:15 INFO - 'TMOUT': '86400', 12:14:15 INFO - 'USER': 'cltbld', 12:14:15 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706', 12:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:15 INFO - '_': '/tools/buildbot/bin/python'} 12:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:15 INFO - Downloading/unpacking jsonschema==2.5.1 12:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:14:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:18 INFO - Downloading functools32-3.2.3-2.tar.gz 12:14:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:14:18 INFO - warning: no files found matching '*.txt' 12:14:18 INFO - no previously-included directories found matching 'build' 12:14:18 INFO - no previously-included directories found matching 'dist' 12:14:18 INFO - no previously-included directories found matching '.git*' 12:14:18 INFO - Installing collected packages: jsonschema, functools32 12:14:18 INFO - Running setup.py install for functools32 12:14:18 INFO - warning: no files found matching '*.txt' 12:14:18 INFO - no previously-included directories found matching 'build' 12:14:18 INFO - no previously-included directories found matching 'dist' 12:14:18 INFO - no previously-included directories found matching '.git*' 12:14:18 INFO - Successfully installed jsonschema functools32 12:14:18 INFO - Cleaning up... 12:14:18 INFO - Return code: 0 12:14:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8110b6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18adca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aaf60>, '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 0x18abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ac1d0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:14:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:14:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:14:18 INFO - Using env: {'DISPLAY': ':0', 12:14:18 INFO - 'HOME': '/home/cltbld', 12:14:18 INFO - 'LANG': 'en_US.UTF-8', 12:14:18 INFO - 'LANGUAGE': 'en_US:en', 12:14:18 INFO - 'LOGNAME': 'cltbld', 12:14:18 INFO - 'MAIL': '/var/mail/cltbld', 12:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:18 INFO - 'MOZ_NO_REMOTE': '1', 12:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:18 INFO - 'NO_EM_RESTART': '1', 12:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:18 INFO - 'PWD': '/builds/slave/test', 12:14:18 INFO - 'SHELL': '/bin/bash', 12:14:18 INFO - 'SHLVL': '1', 12:14:18 INFO - 'TERM': 'linux', 12:14:18 INFO - 'TMOUT': '86400', 12:14:18 INFO - 'USER': 'cltbld', 12:14:18 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706', 12:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:18 INFO - '_': '/tools/buildbot/bin/python'} 12:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:14:18 INFO - Cleaning up... 12:14:18 INFO - Return code: 0 12:14:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8110b6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18adca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aaf60>, '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 0x18abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ac1d0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:14:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:14:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:14:18 INFO - Using env: {'DISPLAY': ':0', 12:14:18 INFO - 'HOME': '/home/cltbld', 12:14:18 INFO - 'LANG': 'en_US.UTF-8', 12:14:18 INFO - 'LANGUAGE': 'en_US:en', 12:14:18 INFO - 'LOGNAME': 'cltbld', 12:14:18 INFO - 'MAIL': '/var/mail/cltbld', 12:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:18 INFO - 'MOZ_NO_REMOTE': '1', 12:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:18 INFO - 'NO_EM_RESTART': '1', 12:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:18 INFO - 'PWD': '/builds/slave/test', 12:14:18 INFO - 'SHELL': '/bin/bash', 12:14:18 INFO - 'SHLVL': '1', 12:14:18 INFO - 'TERM': 'linux', 12:14:18 INFO - 'TMOUT': '86400', 12:14:18 INFO - 'USER': 'cltbld', 12:14:18 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706', 12:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:18 INFO - '_': '/tools/buildbot/bin/python'} 12:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:18 INFO - Downloading/unpacking blobuploader==1.2.4 12:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:20 INFO - Downloading blobuploader-1.2.4.tar.gz 12:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:14:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:14:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:21 INFO - Downloading docopt-0.6.1.tar.gz 12:14:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:14:21 INFO - Installing collected packages: blobuploader, requests, docopt 12:14:21 INFO - Running setup.py install for blobuploader 12:14:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:14:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:14:21 INFO - Running setup.py install for requests 12:14:22 INFO - Running setup.py install for docopt 12:14:22 INFO - Successfully installed blobuploader requests docopt 12:14:22 INFO - Cleaning up... 12:14:22 INFO - Return code: 0 12:14:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:22 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 0x7f8110b6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18adca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aaf60>, '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 0x18abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ac1d0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:14:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:14:22 INFO - Using env: {'DISPLAY': ':0', 12:14:22 INFO - 'HOME': '/home/cltbld', 12:14:22 INFO - 'LANG': 'en_US.UTF-8', 12:14:22 INFO - 'LANGUAGE': 'en_US:en', 12:14:22 INFO - 'LOGNAME': 'cltbld', 12:14:22 INFO - 'MAIL': '/var/mail/cltbld', 12:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:22 INFO - 'MOZ_NO_REMOTE': '1', 12:14:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:22 INFO - 'NO_EM_RESTART': '1', 12:14:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:22 INFO - 'PWD': '/builds/slave/test', 12:14:22 INFO - 'SHELL': '/bin/bash', 12:14:22 INFO - 'SHLVL': '1', 12:14:22 INFO - 'TERM': 'linux', 12:14:22 INFO - 'TMOUT': '86400', 12:14:22 INFO - 'USER': 'cltbld', 12:14:22 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706', 12:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:22 INFO - '_': '/tools/buildbot/bin/python'} 12:14:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:14:22 INFO - Running setup.py (path:/tmp/pip-TnTpFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:14:22 INFO - Running setup.py (path:/tmp/pip-XUKA5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:14:22 INFO - Running setup.py (path:/tmp/pip-DCMt9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:14:22 INFO - Running setup.py (path:/tmp/pip-TRGUrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:14:22 INFO - Running setup.py (path:/tmp/pip-Een6y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:14:22 INFO - Running setup.py (path:/tmp/pip-cUqvZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:14:22 INFO - Running setup.py (path:/tmp/pip-WPnLxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:14:22 INFO - Running setup.py (path:/tmp/pip-_GzMp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:14:23 INFO - Running setup.py (path:/tmp/pip-kdIE_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:14:23 INFO - Running setup.py (path:/tmp/pip-G5209M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:14:23 INFO - Running setup.py (path:/tmp/pip-9CORdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:14:23 INFO - Running setup.py (path:/tmp/pip-un30fL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:14:23 INFO - Running setup.py (path:/tmp/pip-Ti28wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:14:23 INFO - Running setup.py (path:/tmp/pip-2BZRsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:23 INFO - Running setup.py (path:/tmp/pip-B_nwNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:14:23 INFO - Running setup.py (path:/tmp/pip-2ruuVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:14:23 INFO - Running setup.py (path:/tmp/pip-GmofGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:14:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:14:23 INFO - Running setup.py install for manifestparser 12:14:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:14:23 INFO - Running setup.py install for mozcrash 12:14:23 INFO - Running setup.py install for mozdebug 12:14:23 INFO - Running setup.py install for mozdevice 12:14:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:14:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:14:24 INFO - Running setup.py install for mozfile 12:14:24 INFO - Running setup.py install for mozhttpd 12:14:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:14:24 INFO - Running setup.py install for mozinfo 12:14:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:14:24 INFO - Running setup.py install for mozInstall 12:14:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:14:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:14:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:14:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:14:24 INFO - Running setup.py install for mozleak 12:14:24 INFO - Running setup.py install for mozlog 12:14:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:14:24 INFO - Running setup.py install for moznetwork 12:14:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:14:24 INFO - Running setup.py install for mozprocess 12:14:24 INFO - Running setup.py install for mozprofile 12:14:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:14:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:14:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:14:25 INFO - Running setup.py install for mozrunner 12:14:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:14:25 INFO - Running setup.py install for mozscreenshot 12:14:25 INFO - Running setup.py install for moztest 12:14:25 INFO - Running setup.py install for mozversion 12:14:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:14:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:14:25 INFO - Cleaning up... 12:14:25 INFO - Return code: 0 12:14:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:25 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 0x7f8110b6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18adca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aaf60>, '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 0x18abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ac1d0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:14:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:14:25 INFO - Using env: {'DISPLAY': ':0', 12:14:25 INFO - 'HOME': '/home/cltbld', 12:14:25 INFO - 'LANG': 'en_US.UTF-8', 12:14:25 INFO - 'LANGUAGE': 'en_US:en', 12:14:25 INFO - 'LOGNAME': 'cltbld', 12:14:25 INFO - 'MAIL': '/var/mail/cltbld', 12:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:25 INFO - 'MOZ_NO_REMOTE': '1', 12:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:25 INFO - 'NO_EM_RESTART': '1', 12:14:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:25 INFO - 'PWD': '/builds/slave/test', 12:14:25 INFO - 'SHELL': '/bin/bash', 12:14:25 INFO - 'SHLVL': '1', 12:14:25 INFO - 'TERM': 'linux', 12:14:25 INFO - 'TMOUT': '86400', 12:14:25 INFO - 'USER': 'cltbld', 12:14:25 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706', 12:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:25 INFO - '_': '/tools/buildbot/bin/python'} 12:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:14:25 INFO - Running setup.py (path:/tmp/pip-_7tU45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:14:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:14:25 INFO - Running setup.py (path:/tmp/pip-uP789s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:14:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:14:25 INFO - Running setup.py (path:/tmp/pip-DHkoEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:14:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:14:25 INFO - Running setup.py (path:/tmp/pip-SSICDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:14:26 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)) 12:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:14:26 INFO - Running setup.py (path:/tmp/pip-VSpHKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:14:26 INFO - Running setup.py (path:/tmp/pip-xDKvfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:14:26 INFO - Running setup.py (path:/tmp/pip-vRo8n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:14:26 INFO - Running setup.py (path:/tmp/pip-ftWAng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:14:26 INFO - Running setup.py (path:/tmp/pip-aD9G2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:14:26 INFO - Running setup.py (path:/tmp/pip-JmSek2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:14:26 INFO - Running setup.py (path:/tmp/pip-FWyQV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:14:26 INFO - Running setup.py (path:/tmp/pip-mA1jJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:14:26 INFO - Running setup.py (path:/tmp/pip-oDIvvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:14:26 INFO - Running setup.py (path:/tmp/pip-GKpwl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:26 INFO - Running setup.py (path:/tmp/pip-1Mhlaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:14:26 INFO - Running setup.py (path:/tmp/pip-SdPyUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:14:26 INFO - Running setup.py (path:/tmp/pip-wE47p4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:14:26 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)) 12:14:26 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)) 12:14:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:28 INFO - Downloading blessings-1.6.tar.gz 12:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:14:29 INFO - Installing collected packages: blessings 12:14:29 INFO - Running setup.py install for blessings 12:14:29 INFO - Successfully installed blessings 12:14:29 INFO - Cleaning up... 12:14:29 INFO - Return code: 0 12:14:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:14:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:14:29 INFO - Reading from file tmpfile_stdout 12:14:29 INFO - Current package versions: 12:14:29 INFO - argparse == 1.2.1 12:14:29 INFO - blessings == 1.6 12:14:29 INFO - blobuploader == 1.2.4 12:14:29 INFO - docopt == 0.6.1 12:14:29 INFO - functools32 == 3.2.3-2 12:14:29 INFO - jsonschema == 2.5.1 12:14:29 INFO - manifestparser == 1.1 12:14:29 INFO - mozInstall == 1.12 12:14:29 INFO - mozcrash == 1.0 12:14:29 INFO - mozdebug == 0.1 12:14:29 INFO - mozdevice == 0.48 12:14:29 INFO - mozfile == 1.2 12:14:29 INFO - mozhttpd == 0.7 12:14:29 INFO - mozinfo == 0.9 12:14:29 INFO - mozleak == 0.1 12:14:29 INFO - mozlog == 3.4 12:14:29 INFO - moznetwork == 0.27 12:14:29 INFO - mozprocess == 0.23 12:14:29 INFO - mozprofile == 0.28 12:14:29 INFO - mozrunner == 6.13 12:14:29 INFO - mozscreenshot == 0.1 12:14:29 INFO - mozsystemmonitor == 0.3 12:14:29 INFO - moztest == 0.8 12:14:29 INFO - mozversion == 1.4 12:14:29 INFO - psutil == 3.1.1 12:14:29 INFO - requests == 1.2.3 12:14:29 INFO - wsgiref == 0.1.2 12:14:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:29 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 0x7f8110b6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18adca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aaf60>, '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 0x18abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ac1d0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:14:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:14:29 INFO - Using env: {'DISPLAY': ':0', 12:14:29 INFO - 'HOME': '/home/cltbld', 12:14:29 INFO - 'LANG': 'en_US.UTF-8', 12:14:29 INFO - 'LANGUAGE': 'en_US:en', 12:14:29 INFO - 'LOGNAME': 'cltbld', 12:14:29 INFO - 'MAIL': '/var/mail/cltbld', 12:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:29 INFO - 'MOZ_NO_REMOTE': '1', 12:14:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:29 INFO - 'NO_EM_RESTART': '1', 12:14:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:29 INFO - 'PWD': '/builds/slave/test', 12:14:29 INFO - 'SHELL': '/bin/bash', 12:14:29 INFO - 'SHLVL': '1', 12:14:29 INFO - 'TERM': 'linux', 12:14:29 INFO - 'TMOUT': '86400', 12:14:29 INFO - 'USER': 'cltbld', 12:14:29 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706', 12:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:29 INFO - '_': '/tools/buildbot/bin/python'} 12:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:14:29 INFO - Cleaning up... 12:14:29 INFO - Return code: 0 12:14:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:29 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 0x7f8110b6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18adca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aaf60>, '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 0x18abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ac1d0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:14:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:14:29 INFO - Using env: {'DISPLAY': ':0', 12:14:29 INFO - 'HOME': '/home/cltbld', 12:14:29 INFO - 'LANG': 'en_US.UTF-8', 12:14:29 INFO - 'LANGUAGE': 'en_US:en', 12:14:29 INFO - 'LOGNAME': 'cltbld', 12:14:29 INFO - 'MAIL': '/var/mail/cltbld', 12:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:29 INFO - 'MOZ_NO_REMOTE': '1', 12:14:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:29 INFO - 'NO_EM_RESTART': '1', 12:14:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:29 INFO - 'PWD': '/builds/slave/test', 12:14:29 INFO - 'SHELL': '/bin/bash', 12:14:29 INFO - 'SHLVL': '1', 12:14:29 INFO - 'TERM': 'linux', 12:14:29 INFO - 'TMOUT': '86400', 12:14:29 INFO - 'USER': 'cltbld', 12:14:29 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706', 12:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:29 INFO - '_': '/tools/buildbot/bin/python'} 12:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:14:29 INFO - Cleaning up... 12:14:29 INFO - Return code: 0 12:14:29 INFO - Running post-action listener: _resource_record_post_action 12:14:29 INFO - Running post-action listener: _start_resource_monitoring 12:14:29 INFO - Starting resource monitoring. 12:14:29 INFO - [mozharness: 2017-02-13 20:14:29.987422Z] Finished create-virtualenv step (success) 12:14:29 INFO - [mozharness: 2017-02-13 20:14:29.988092Z] Running install step. 12:14:29 INFO - Running pre-action listener: _resource_record_pre_action 12:14:29 INFO - Running main action method: install 12:14:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:14:30 INFO - Reading from file tmpfile_stdout 12:14:30 INFO - Detecting whether we're running mozinstall >=1.0... 12:14:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:14:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:14:30 INFO - Reading from file tmpfile_stdout 12:14:30 INFO - Output received: 12:14:30 INFO - Usage: mozinstall [options] installer 12:14:30 INFO - Options: 12:14:30 INFO - -h, --help show this help message and exit 12:14:30 INFO - -d DEST, --destination=DEST 12:14:30 INFO - Directory to install application into. [default: 12:14:30 INFO - "/builds/slave/test"] 12:14:30 INFO - --app=APP Application being installed. [default: firefox] 12:14:30 INFO - mkdir: /builds/slave/test/build/application 12:14:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:14:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:14:43 INFO - Reading from file tmpfile_stdout 12:14:43 INFO - Output received: 12:14:43 INFO - /builds/slave/test/build/application/firefox/firefox 12:14:43 INFO - Running post-action listener: _resource_record_post_action 12:14:43 INFO - [mozharness: 2017-02-13 20:14:43.936783Z] Finished install step (success) 12:14:43 INFO - [mozharness: 2017-02-13 20:14:43.937028Z] Running run-tests step. 12:14:43 INFO - Running pre-action listener: _resource_record_pre_action 12:14:43 INFO - Running main action method: run_tests 12:14:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:14:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:14:43 INFO - Python 2.7.3 12:14:43 INFO - Return code: 0 12:14:43 INFO - grabbing minidump binary from tooltool 12:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:43 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 0x18aaf60>, '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 0x18abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ac1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:14:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:14:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:14:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:14:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:14:44 INFO - Return code: 0 12:14:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:14:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:14:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:14:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:14:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:14:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 12:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-089 --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 12:14:44 INFO - Using env: {'DISPLAY': ':0', 12:14:44 INFO - 'HOME': '/home/cltbld', 12:14:44 INFO - 'LANG': 'en_US.UTF-8', 12:14:44 INFO - 'LANGUAGE': 'en_US:en', 12:14:44 INFO - 'LOGNAME': 'cltbld', 12:14:44 INFO - 'MAIL': '/var/mail/cltbld', 12:14:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:14:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:44 INFO - 'MOZ_NO_REMOTE': '1', 12:14:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:44 INFO - 'NO_EM_RESTART': '1', 12:14:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:44 INFO - 'PWD': '/builds/slave/test', 12:14:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:14:44 INFO - 'SHELL': '/bin/bash', 12:14:44 INFO - 'SHLVL': '1', 12:14:44 INFO - 'TERM': 'linux', 12:14:44 INFO - 'TMOUT': '86400', 12:14:44 INFO - 'USER': 'cltbld', 12:14:44 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706', 12:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:44 INFO - '_': '/tools/buildbot/bin/python'} 12:14:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 12:14:44 INFO - mozversion application_buildid: 20170213102439 12:14:44 INFO - mozversion application_changeset: 4ad8573642c78523c549e9ee3b90c24f9a464834 12:14:44 INFO - mozversion application_display_name: Firefox 12:14:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:14:44 INFO - mozversion application_name: Firefox 12:14:44 INFO - mozversion application_remotingname: firefox 12:14:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:14:44 INFO - mozversion application_vendor: Mozilla 12:14:44 INFO - mozversion application_version: 52.0 12:14:44 INFO - mozversion platform_buildid: 20170213102439 12:14:44 INFO - mozversion platform_changeset: 4ad8573642c78523c549e9ee3b90c24f9a464834 12:14:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:14:44 INFO - mozversion platform_version: 52.0 12:14:44 INFO - using testdate: 1487016884 12:14:44 INFO - actual date: 1487016884 12:14:44 INFO - starting webserver on 'localhost:38523' 12:14:44 INFO - SUITE-START | Running 2 tests 12:14:44 INFO - TEST-START | dromaeo_css 12:14:44 INFO - operating with platform_type : linux_ 12:14:44 INFO - Initialising browser for dromaeo_css test... 12:14:44 INFO - TEST-INFO | started process 18960 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0Z8SqZ/profile http://localhost:38523/getInfo.html) 12:14:48 INFO - PROCESS | 18960 | __metrics Screen width/height:1600/1200 12:14:48 INFO - PROCESS | 18960 | colorDepth:24 12:14:48 INFO - PROCESS | 18960 | Browser inner width/height: 1024/697 12:14:48 INFO - PROCESS | 18960 | __metrics 12:14:48 INFO - PROCESS | 18960 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:14:48 INFO - PROCESS | 18960 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:14:49 INFO - PROCESS | 18960 | console.error: PushService: 12:14:49 INFO - PROCESS | 18960 | stateChangeProcessEnqueue: Error transitioning state 12:14:49 INFO - PROCESS | 18960 | UnknownError 12:14:50 INFO - TEST-INFO | 18960: exit 0 12:14:50 INFO - Browser initialized. 12:14:50 INFO - Running cycle 1/1 for dromaeo_css test... 12:14:50 INFO - TEST-INFO | started process 19051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0Z8SqZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:15:01 INFO - PROCESS | 19051 | RSS: Main: 141537280 12:15:01 INFO - PROCESS | 19051 | 12:18:03 INFO - PROCESS | 19051 | Cycle 1(1): loaded http://localhost:38523/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38523/tests/dromaeo/cssquery-ext.html) 12:18:04 INFO - PROCESS | 19051 | RSS: Main: 248975360 12:18:04 INFO - PROCESS | 19051 | 12:21:06 INFO - PROCESS | 19051 | Cycle 1(1): loaded http://localhost:38523/tests/dromaeo/cssquery-ext.html (next: http://localhost:38523/tests/dromaeo/cssquery-jquery.html) 12:21:07 INFO - PROCESS | 19051 | RSS: Main: 220598272 12:21:07 INFO - PROCESS | 19051 | 12:24:09 INFO - PROCESS | 19051 | Cycle 1(1): loaded http://localhost:38523/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38523/tests/dromaeo/cssquery-mootools.html) 12:24:09 INFO - PROCESS | 19051 | RSS: Main: 173977600 12:24:09 INFO - PROCESS | 19051 | 12:27:11 INFO - PROCESS | 19051 | Cycle 1(1): loaded http://localhost:38523/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38523/tests/dromaeo/cssquery-prototype.html) 12:27:12 INFO - PROCESS | 19051 | RSS: Main: 221618176 12:27:12 INFO - PROCESS | 19051 | 12:30:14 INFO - PROCESS | 19051 | Cycle 1(1): loaded http://localhost:38523/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38523/tests/dromaeo/cssquery-yui.html) 12:30:15 INFO - PROCESS | 19051 | RSS: Main: 174833664 12:30:15 INFO - PROCESS | 19051 | 12:33:17 INFO - PROCESS | 19051 | Cycle 1(1): loaded http://localhost:38523/tests/dromaeo/cssquery-yui.html (next: http://localhost:38523/tests/dromaeo/cssquery-dojo.html) 12:33:18 INFO - PROCESS | 19051 | RSS: Main: 260276224 12:33:18 INFO - PROCESS | 19051 | 12:33:18 INFO - PROCESS | 19051 | __start_tp_report 12:33:18 INFO - PROCESS | 19051 | _x_x_mozilla_page_load 12:33:18 INFO - PROCESS | 19051 | _x_x_mozilla_page_load_details 12:33:18 INFO - PROCESS | 19051 | |i|pagename|runs| 12:33:18 INFO - PROCESS | 19051 | |0;dojo.html;3139.748820094392;3186.904392868213;3188.346388990256;3209.406259841931;3230.370077834823;5477.123660214362;5507.173923911415;5539.501444869961;5557;5581.693006884625;5565.749541270642;5596.916046259309;5600.775968961247;5601;5604.579656525756;5028.974855125728;5049.747512624373;5084.211947148198;5111.412187598418;5132.666376685522;4948.480409556981;4950.9257361139435;4973.626977976648;5084.415292241402;5138.691678499284;5021.698698078127;5080.110980578403;5084.491550844905;5104.081265372231;5113.437521872591;5095.108356037697;5098.694078355274;5106.69359838409;5114.616403769695;5128.71792051437;4882.292067650171;4931.137051016058;4951.529604687549;5006.549410553068;5013.197888337849;5421.484958928895;5442.074847275972;5443.5100840924115;5490.780368785244;5539.279893613845;5925.20009798676;5930.1401296812155;5935.317438494542;5941.910871336933;5948.881022379572;5741.655500669973;5818.389069147721;5894.882102357972;5900.557458190653;5952.9107063394085;5472.863178420532;5506.531944784698;5510.008198524264;5513.7794488220825;5537.750801213955;6030.517558595302;6039.698015099228;6041.154238406627;6041.818745437644;6073.210482637229;5698.515626171822;5751.022326204556;5827.504662103684;5832;5832.795852145239;5839.591228613956;5855.970720146372;5872.911906321408;5893.970530147321;5913.881722365529;5874.823755287348;5878.853028674232;5882.676452795052;5886.117082437669;5888.087346461305;5841.591088623755;5886.941130588725;5888.499477544457;5890.6171098879295;5911.438413350725;4328.913421731548;4344.413504176959;4399.186150562156;4401.955980440219;4410.757408342508;3926.960730392717;3934.429507721364;3943.329633962176;3966.722329436912;3966.861159859391;5565.666060036411;5610.354809196913;5615.747291371898;5618.157276408571;5645.068563686946;5781.53747700183;5805.88388232233;5863.589548731547;5878.030125029322;5950.583459157904;5567.47109024642;5595.552355811526;5612.045952188138;5619.578531610146;5648.576356773258;5104.387473503203;5120.18077107661;5122.282880396748;5123.410807757081;5147.510986456281;5883.264591926009;5946.583739138218;6095.542834287357;6157.076438534255;6172.382761723792;5970.283565972111;6011.0382338825575;6013.278406591237;6015.608985415934;6039.728212230548;6192.052484160345;6210.937890621217;6227.314995350417;6229.3770622939155;6231.53263505248;5612.971935140298;5649.519790817826;5808.651480911159;5903.144044113666;5943.821685349447;5865.354810970704;5932.347441781487;5935.673537955454;5950.761969521171;5969.044952807703;5737.5983681141915;5750.396208398225;5779.479846813807;5784.739686714192;5789.363170051207;5642.774289028557;5724.885502290014;5777.768889244383;5791.507721843691;5797.971010144923;5619.409961954099;5664.348599911063;5682.659040457585;5727.255456790591;5755.798547050833;5763.077907534775;5780.768769249351;5803.593748437569;5806.042003069615;5808.186853840551;5529.281193444826;5566.22072909801;5586.720663966867;5678.545716342765;5699.116636921284 12:33:18 INFO - PROCESS | 19051 | |1;ext.html;552.1457741265253;583.891979983703;602.8372339468343;605.3643674142147;623.4326762645993;30166.24584385389;36642.63357366426;37568.81215593918;37633.43549846748;37914.810425947864;41229.38155927663;41678;41709.16581668365;41759.37360939589;41769.373459398055;8177.9182208178045;8381.07808141104;8676.609552570118;8858.822823543525;8866.335024873128;10357.637482688107;10648.41433721145;10672.199585031114;10860.511276992514;10888.455577221108;10660.147188224963;10694.679159625224;10756.78486430271;10761.677149685522;10762.085222756075;10624.946875265652;10662.093722033636;10685.519151638116;10689;10690.465476726133;10584.841227381596;10649.148068154607;10662.413567253798;10663.360198388122;10678.038976492153;37489;37553.812230938944;37564.812175939216;37721.24557508862;37736.622633773586;3357.5635167428077;3408.727301815849;3466.0814884055744;3629.310431018098;3691.335559599271;28395.716042839515;28782.280442988882;28870.42259154826;28989.56515652267;29013.709862901313;3598.334308153;3611.530501034849;3622.9275414491826;3647.781133131994;3671.1739858531882;333447;334364;334718.99999999756;334866;336111;33442.66557334444;35466.29067418637;54012.45987540153;55130;55850;35706.64293357033;36251.63748362535;36268.637313627056;36338.63661363405;36693.44959825605;14199.71600567983;14200.928995355163;14203.715925681428;14208.715825683428;14239.145651260958;11095.44522773858;11454.828177577343;11727.824082638766;11873.228240164362;12007.279563226235;8453.112423195598;8470.745877623682;8529.189726975927;8560;8572.271356934605;3220.85506152219;3240.7893486923276;3284.1625385527013;3305.6694330567234;3326.0542582588973;845.8984921809422;850.3324889961351;900.7748062984253;933.5332333833084;937.4843835890233;27355.86322068377;27788.988181032142;28542.85728571344;28554.428911421655;29038.564421533694;992.1080051649361;998.1515711645044;1017.3844823881593;1026.4918865161792;1046.5918291866178;13201.73596528064;15024.774628380583;16215;16321;16560.337586496647;529851;532390;533916;535414;536684;49801.50198497969;49892.50107498879;50006.74996624994;50030.49969500331;50084.499155008714;1136.494260054268;1187.3469591724518;1218.524775337619;1270.1807334269345;1277.1060257819563;27416.725832741417;28623.284417888888;29107.417851643273;29580.704192957794;30283.848580756956;43047.139057219305;51598.48401515937;52896.471035289156;53091;54873.725631371584;379457;382941;383065;383201;383598;33641.49537756887;34755.652443476254;34762;36406.453903190944;39088;40256.798716007404;41382;41743.1651366977;42470.575294246664;43102.78448607737;35393.469097964065;35468.46797298094;35502.8224858874;35633.82183089068;35972.64027359693;36326.27347453089;36537.81731091434;37167.6283237175;37418.625813742605;38062;36040;36078;36255;36491;36641.81679091587;31437.52843707392;34144.14639634029;34488.310233794684;34522.482162767075;34604;25047.248582542554;25834.741652583234;26046.609300860124;26062;26504 12:33:18 INFO - PROCESS | 19051 | |2;jquery.html;387.6181960768641;387.901085223268;401.34981330245006;408.3079180788563;417.3801904172304;14187.219702916336;14532.418703251857;16806.243719032642;17886.821131788696;17934.5516362091;14694.853051469481;17032;17073.231704573293;17303;17357.82642173578;5805.12923061541;6015.939840601582;6023.247094113236;6026.367231440701;6033.09503574463;5642.802501912434;5875.676837773921;5896.056630939051;5907.320658124307;5909.645421274738;5678.375378708339;5831.883362332772;5868.559858010645;5877.735501902424;5879.382664820197;5871.6183448075735;5875.1187321901625;5887.911681324784;5905.645661260338;5906.468417842415;5265.394479634852;5398.379186393576;5400.891982160335;5402.459754024566;5487.2317875497465;14109.78835317471;14379.856201437957;14384;14402.495912643111;20305.289314874055;2474.81438892082;2496.750324967507;2517.4587463695393;2530.4559519703166;2691.3944362518278;9617.182539484153;10185.643502477378;10206.795864082676;10588.205884558613;10629.04338609521;2002.3092033248506;2024.3926821953355;2026.118638392304;2057.238821635989;2108.3780284816016;71971.64014179895;73512.63243683802;73801.26198737997;82952.58523707403;85963;10434.68695939123;10760.838587421194;11025.44872756359;11282.661520154408;11294.774104517863;16086;16137.354505819636;16148.111853847917;16149.919250403673;16170.353185872433;7748.22517748232;7928.7224947127725;7982.182804035614;8078.151794061657;8125.268725814705;7059.682314295869;7101.751438699724;7296.270372962767;7316.122065352191;7451;4704.5765881070865;4801.663883528189;4806.49531799156;4902.558769710743;4913;2013.1343522285558;2056.4653190170366;2084.4997200672033;2085.5411809401908;2138.3478039198194;839.7102999465175;889.2841262783521;889.6174644902625;902.6389444222364;967.298708436378;16753.748693769605;16848.24182911772;16967.321307147577;18288.268469261347;19368.4189474316;858.3733874271817;895.7984453498041;908.40953380302;918.2653876898588;919.94480331179;9831.508424578886;10197.541110650038;10426.426546540013;10529.473526323653;10653.147748180127;442941;443697;453092;460675;472807;92428.53785731163;93324;93589.5320523393;93685;93760.53119734494;910.6402970826487;938.5729493080632;970.1123472023161;994.8607194992707;999.820032394176;15341.923290383924;16063.91968040199;16159.515214543113;16450;16967.745483817507;42223.366649500895;42764.78617606892;42865.78567107269;43377;44371.11257774762;53745.73127134339;54471.45528544664;57125.71437142788;57448.42551574598;58773;8713.30293576525;8866.556672166495;8910.465372077697;8958.462492250486;8984.550772461482;8281.668733250603;9296.767580810534;11040.889591103985;11576.88423115758;12211.572594959134;11107.44462776874;11276.565128291553;11344.546218151181;11362.886371136514;11635.767284654428;10616;10961.123110151328;10961.616343427942;10995;11402.429878505876;11027.44862756875;11048.834267485834;11081.335119892832;11222.607208747655;11253.71865703364;8494.447860889022;8902.59938302765;8965.865512017455;8970.775730606527;8995.100489950952;10342.689719308433;10757.30077544957;11027.503762330874;11028.5037173329;11801.114916381477 12:33:18 INFO - PROCESS | 19051 | |3;mootools.html;1321.9008574356922;1336.6123824091014;1379.5447502324234;1524.7865298858155;1548.3806477409041;8460.619272132753;9070.727878163649;9079.273658107351;9084.046175151612;9101.59042843072;7819.100803407609;8035.316998055172;8049.07435644901;8246.505209687422;8885.95557022214;2291.2667946257206;2368.0409434179187;2370.8696021718797;2381.333226696519;2387.797037251827;2408.8795560222006;2450.4853980664084;2475.801935845137;2483.7143728471187;2488.850668959859;2111.250506070346;2175.575762726269;2438.926832195028;2463.1255904154036;2463.581191197492;2364.290712786166;2415.842970206931;2429.453372991072;2451.460678650712;2459.139301244568;2400.447896983686;2411.216354684717;2412.541617092747;2418.1415597462824;2451.644511545816;8889.911100889038;8984.326175536795;8986.820263594756;8987.820243595157;8999.19007289347;5317.707526086064;5485.561155107582;5486.753096110685;5489.64317319373;5491.7254137292975;3020.5318175682805;3171.809691418522;3256.544083828266;3360.8487618057247;3361.4957756336503;1110.1840147491587;1147.512307269407;1158.8841115888429;1188.9227200232044;1209.818527220924;12790.552330668383;12793.424295906707;12799.808002879965;12816.80774788379;12830.101892867502;4784.6889952153;4797.928031079537;4818.927716084261;4834.854954351375;4980.377452818398;9670.613175473043;9788;9805.950970245245;9808;9819.75450613726;5429.321334833146;5431.456854314616;5435.918461223085;5436.130219164915;5442.8911421771345;4926.8768280793265;4968;5014.423341315723;5088.872778180576;5091.261767043832;3703.666669999659;3716.7769933804057;3896.1818018215927;3910.3156947534067;3921.9019524512114;1142.3602782441692;1146.5471138900255;1169.2867350915935;1180.4333919718583;1196.8862958018974;866.6316815353575;880.3089574683843;880.6345366672759;901.8466860633577;916.0015583014546;6089.5737298388685;6230.158928544679;6231.40801623845;6328.968355158195;6353.904691429632;878.7319867440365;922.087133737595;952.1288021460286;999.4552968632113;1027.712240572641;4155.605217504332;4236.957630423718;4269.658427325807;4364.54172311909;4381.824727010884;10863.83704244437;11359.829602555968;11367.033802126913;11394.48724807369;11398.316101033965;11313;11346;11347.148963827582;11348.319100853974;11355.602553910574;7796.961015195001;8065.516069035877;8066.556339401389;8307.792305192297;8318.958405207935;5826.271716035496;5836.358000620014;5867.882642347044;5968;6229.875402492015;10378.377297362182;10384;10423.583056677951;10471.476426178813;10518.263721539724;10511.369317840954;10528.210384221367;10532.52603632823;10582.894171058191;10609.575616975235;7956.403269754907;8126.309263712415;8128.3497320213055;8130.268275855202;8136.75589732309;8439;8514.063453020286;8574.31405487572;8581.35639827003;8655.04794472595;7782.455228133977;7824.374050076094;7866.960665196638;7875;8068.435209535511;7513.812154695957;7666.425018123551;7732.8453430932195;7914.44598878073;7927.246911543394;6856.314368563104;6965.860682786417;6971.930280697128;6976.5465244758925;6978.965105174441;5164.845054648216;5190.117679994485;5209.817656382009;5212.843614691566;5375.6774593524515;5433.701146436984;5439.782408703766;5470.808521701881;5485.780568777204;5626.524473885104 12:33:18 INFO - PROCESS | 19051 | |4;prototype.html;346.6897127071271;352.8623836703686;356.3710051758646;359.5164503742466;364.8595290813036;5235.214717792333;5385.78456861725;5423.132298832183;5431.4568543145715;5433.402325744165;5217.399999000116;5263.578913686905;5307.389650190229;5332.840014799553;5398.64908780929;4198.6641068714425;4212.620864122236;4223.577642235782;4239.576042395766;4330.826766929335;4219.894502637428;4263.104748002923;4283.907603561088;4301.978490107545;4315.978420107895;4236;4242.109157077018;4242.639375653073;4244.236037513247;4254.595813397737;4232.582085001528;4233.936490952638;4244.575542445777;4245.6815738819405;4288.270993931039;3638.5263968092963;3743.7753734776;3761.2665530221616;3771.7548359356556;3829.8468061277517;5207.427183009866;5228.843134705965;5242.55438287746;5244.81643142492;5261.105612045923;4844.128056949748;4872.756362181876;4881.975590122062;4884.682495637772;4902.926456103161;5422.783088676449;5458.372287186985;5505.917411238835;5555.250041244421;5650.604457687963;4117.444145040411;4118.361653943613;4119.423280740669;4120.608542188487;4121.5878412158845;5811.970940145315;5863.472287494146;5878.794242201502;5893.410658934073;5902.763889444417;4133.026233372999;4133.23535145999;4217;4228.513720922072;4236.788160591958;4261.509926358509;4266.189424009428;4278.465191851019;4279.764612946318;4296.978515107467;4824.372831531879;4828.5412885775795;4852.684575502581;4864.610831133501;4885.682430641997;5407.729183641841;5623.578231632644;5640;5660.97169514158;5703.800366987219;1361.5642994241748;1384.536180379584;1397.5108711950736;1399.4751968011994;1438.26648409312;948.393028461785;958.2908647600865;980.2892902645525;981.4111533080095;988.7824678570703;5117.795288188505;5141.691498510027;5179.766910488962;5180.507851754077;5200.609954253446;5525.557955363562;5527.585431092603;5527.723613819293;5530.446955304518;5545.390007099216;5164.3802743671;5181.4041385240425;5195.7142357170715;5216.321878155892;5395;2889.515017085305;2959.733623973853;2960.6299212598424;2963.8369889655846;2979.2105092150596;5784.334801497797;5785.247917770663;5794.768209271582;5798.82603521895;5833.241678581842;5535.616095976006;5637.46444087811;5657.9249942511615;5679.829605111853;5715.628484148517;5700.287464066992;5747.137929310553;5751.654900705971;5790.420957904176;5838.241028666162;5377.784888604569;5558.638688485397;5625.324961004542;5656.971715141398;5685.77256909719;5522.502974732132;5526.834194974157;5549.361823390362;5566.276384070045;5582.358028826737;5793.36273009977;5807;5837.795677151449;5849.268841394825;5854.824355269348;3995.7003224757677;4123.731957422758;4138.544760076329;4163.625273725379;4169.8957526062095;5511.283533140666;5614.550835933034;5619.80827477276;5640.266765320482;5678.488935995781;5485.793125512381;5587.413321601336;5590.161475778666;5618.971905140448;5631.408702086222;5570.2480165177185;5608.635438696471;5643.943560564342;5650.576206784425;5654.738104758129;5373.704446255493;5587.720613969366;5602.431319230622;5608.355039170385;5624.831255062355;5633.577481688972;5642.492175704207;5672.405351665165;5699.632088298696;5712.800311934374;5436.794649787984;5531.419200983839;5553.555715542828;5558.249636299048;5559.554515825996 12:33:18 INFO - PROCESS | 19051 | |5;yui.html;631.3055638797322;661.8477750117474;670.4502308107354;682.5529278322697;701.8070030741549;12575.18261313014;12743.681407964805;12794.872051279484;12838.486460541579;12840.35798210088;11316.830247546293;11395;11405.771884562304;11416.771664566724;11440.599579014735;528.1496790167827;542.6282996147652;600.9338972713009;627.0656721485;636.5639536917226;612.9387061293879;613.8956377415827;614.5452365249705;614.6342925959048;614.7540983606549;669.4276393683404;674.3256743256743;674.4806498995771;674.6660403100473;674.8414122681166;664.4617859533793;671.4628297362091;672.5292295393219;673.1686367336335;674.2280089297751;465.96505262105137;467.7661169415292;469.77216050215617;470.3978906999047;470.82814772608094;11223.831642525369;11279.32324060559;11299.096072314194;11344.659660210207;11367.488463019185;12050.638480845588;12119.636410907688;12732.681682957907;12751.298678572675;12944.15862968904;10165.59337626494;10511.52698128586;10684.358938463716;10735.087517561016;10766.676999689944;3543.1496440854266;3543.2204914918675;3618.2039951210954;3630.981845090784;3681.7606855554573;62625.686871565806;62988;63095.738085238496;65169.67415162894;65558;8936.776580585538;9034.819303613891;9177.587008584629;9389.530523473799;9550.665726699532;15062.096274223582;15198.316075776616;15270.160141192118;15542.456014039455;15692.92153539225;7171.964140179266;7235.710571577183;7329.120505539263;7424.777256682308;7585.848283034308;4285.892852678708;4405.207062728676;4405.823767049282;4421.756803375845;4439.445069366329;2918.8978385756823;3041.9391612167633;3044.6498652655227;3046.84765761711;3049.268175637831;531.2482836785905;531.6252042310163;536.919462080691;559.295287937194;560.4255637971112;589.3016775121495;624.2446639566085;645.6997496164212;664.1134085995154;667.0694381338103;8417.494950303002;8880.200781929529;9016.909830901739;9067.909320906838;9100.590473428712;687.9380855723009;690.2786588015535;693.2270518371979;716.4948711158621;724.3263764698776;4255.085156691326;4304.096139810612;4357.629601483909;4373.169097871394;4434.467863856358;79526.60236698779;84451;88353.55823220842;88827;90462;47949.80125496891;48252.27621585679;48451;61128.694356528824;79613.20386796058;67139;67280;67362.32637673561;67462.98805517922;67887;8360.54017029045;8476.92238997032;8536;8574.614142363484;8627.180417860292;31872.840635796674;42509;45562.772186138856;48790.51209488002;51234;58188.70905645445;58575.4142458587;59852.70073649604;61146;61657.383426165165;10800.612084206372;10899.945500272448;11233.887661123284;11281.548738050386;11559.479823407799;13259.337033148497;13504.324783760969;13519.324033798073;13899.930500347433;14418.855811441752;11401.144914131639;11656.125790565571;12041;12082.154249202824;12146.271223726251;11413.60052398162;11782.882171178178;11862.22895511789;12034.157608967289;12148.635540933787;11162.944185279022;11164.49759760829;11174.608888688857;11284.774304514029;11716.179867409199;10102.89897101049;10232.53953572106;10347.223958203014;10405.635802746867;10705.518251678537;10094;10419.53112109972;10429.895701042893;10473.842892356468;10483.737906552396 12:33:18 INFO - PROCESS | 19051 | __end_tp_report 12:33:18 INFO - PROCESS | 19051 | __start_cc_report 12:33:18 INFO - PROCESS | 19051 | _x_x_mozilla_cycle_collect,1001 12:33:18 INFO - PROCESS | 19051 | __end_cc_report 12:33:18 INFO - PROCESS | 19051 | __startTimestamp1487017998164__endTimestamp 12:33:18 INFO - PROCESS | 19051 | 12:33:18 INFO - PROCESS | 19051 | ------- Summary: start ------- 12:33:18 INFO - PROCESS | 19051 | Number of tests: 6 12:33:18 INFO - PROCESS | 19051 | 12:33:18 INFO - PROCESS | 19051 | [#0] dojo.html Cycles:165 Average:5483.02 Median:5664.35 stddev:633.19 (11.2%) stddev-sans-first:607.87 12:33:18 INFO - PROCESS | 19051 | Values: 3139.7 3186.9 3188.3 3209.4 3230.4 5477.1 5507.2 5539.5 5557.0 5581.7 5565.7 5596.9 5600.8 5601.0 5604.6 5029.0 5049.7 5084.2 5111.4 5132.7 4948.5 4950.9 4973.6 5084.4 5138.7 5021.7 5080.1 5084.5 5104.1 5113.4 5095.1 5098.7 5106.7 5114.6 5128.7 4882.3 4931.1 4951.5 5006.5 5013.2 5421.5 5442.1 5443.5 5490.8 5539.3 5925.2 5930.1 5935.3 5941.9 5948.9 5741.7 5818.4 5894.9 5900.6 5952.9 5472.9 5506.5 5510.0 5513.8 5537.8 6030.5 6039.7 6041.2 6041.8 6073.2 5698.5 5751.0 5827.5 5832.0 5832.8 5839.6 5856.0 5872.9 5894.0 5913.9 5874.8 5878.9 5882.7 5886.1 5888.1 5841.6 5886.9 5888.5 5890.6 5911.4 4328.9 4344.4 4399.2 4402.0 4410.8 3927.0 3934.4 3943.3 3966.7 3966.9 5565.7 5610.4 5615.7 5618.2 5645.1 5781.5 5805.9 5863.6 5878.0 5950.6 5567.5 5595.6 5612.0 5619.6 5648.6 5104.4 5120.2 5122.3 5123.4 5147.5 5883.3 5946.6 6095.5 6157.1 6172.4 5970.3 6011.0 6013.3 6015.6 6039.7 6192.1 6210.9 6227.3 6229.4 6231.5 5613.0 5649.5 5808.7 5903.1 5943.8 5865.4 5932.3 5935.7 5950.8 5969.0 5737.6 5750.4 5779.5 5784.7 5789.4 5642.8 5724.9 5777.8 5791.5 5798.0 5619.4 5664.3 5682.7 5727.3 5755.8 5763.1 5780.8 5803.6 5806.0 5808.2 5529.3 5566.2 5586.7 5678.5 5699.1 12:33:18 INFO - PROCESS | 19051 | 12:33:18 INFO - PROCESS | 19051 | [#1] ext.html Cycles:180 Average:55492.77 Median:35670.23 stddev:113095.95 (317.1%) stddev-sans-first:113337.99 12:33:18 INFO - PROCESS | 19051 | Values: 552.1 583.9 602.8 605.4 623.4 30166.2 36642.6 37568.8 37633.4 37914.8 41229.4 41678.0 41709.2 41759.4 41769.4 8177.9 8381.1 8676.6 8858.8 8866.3 10357.6 10648.4 10672.2 10860.5 10888.5 10660.1 10694.7 10756.8 10761.7 10762.1 10624.9 10662.1 10685.5 10689.0 10690.5 10584.8 10649.1 10662.4 10663.4 10678.0 37489.0 37553.8 37564.8 37721.2 37736.6 3357.6 3408.7 3466.1 3629.3 3691.3 28395.7 28782.3 28870.4 28989.6 29013.7 3598.3 3611.5 3622.9 3647.8 3671.2 333447.0 334364.0 334719.0 334866.0 336111.0 33442.7 35466.3 54012.5 55130.0 55850.0 35706.6 36251.6 36268.6 36338.6 36693.4 14199.7 14200.9 14203.7 14208.7 14239.1 11095.4 11454.8 11727.8 11873.2 12007.3 8453.1 8470.7 8529.2 8560.0 8572.3 3220.9 3240.8 3284.2 3305.7 3326.1 845.9 850.3 900.8 933.5 937.5 27355.9 27789.0 28542.9 28554.4 29038.6 992.1 998.2 1017.4 1026.5 1046.6 13201.7 15024.8 16215.0 16321.0 16560.3 529851.0 532390.0 533916.0 535414.0 536684.0 49801.5 49892.5 50006.7 50030.5 50084.5 1136.5 1187.3 1218.5 1270.2 1277.1 27416.7 28623.3 29107.4 29580.7 30283.8 43047.1 51598.5 52896.5 53091.0 54873.7 379457.0 382941.0 383065.0 383201.0 383598.0 33641.5 34755.7 34762.0 36406.5 39088.0 40256.8 41382.0 41743.2 42470.6 43102.8 35393.5 35468.5 35502.8 35633.8 35972.6 36326.3 36537.8 37167.6 37418.6 38062.0 36040.0 36078.0 36255.0 36491.0 36641.8 31437.5 34144.1 34488.3 34522.5 34604.0 25047.2 25834.7 26046.6 26062.0 26504.0 12:33:18 INFO - PROCESS | 19051 | 12:33:18 INFO - PROCESS | 19051 | [#2] jquery.html Cycles:180 Average:27404.15 Median:443319.00 stddev:75237.01 (17.0%) stddev-sans-first:75420.72 12:33:18 INFO - PROCESS | 19051 | Values: 387.6 387.9 401.3 408.3 417.4 14187.2 14532.4 16806.2 17886.8 17934.6 14694.9 17032.0 17073.2 17303.0 17357.8 5805.1 6015.9 6023.2 6026.4 6033.1 5642.8 5875.7 5896.1 5907.3 5909.6 5678.4 5831.9 5868.6 5877.7 5879.4 5871.6 5875.1 5887.9 5905.6 5906.5 5265.4 5398.4 5400.9 5402.5 5487.2 14109.8 14379.9 14384.0 14402.5 20305.3 2474.8 2496.8 2517.5 2530.5 2691.4 9617.2 10185.6 10206.8 10588.2 10629.0 2002.3 2024.4 2026.1 2057.2 2108.4 71971.6 73512.6 73801.3 82952.6 85963.0 10434.7 10760.8 11025.4 11282.7 11294.8 16086.0 16137.4 16148.1 16149.9 16170.4 7748.2 7928.7 7982.2 8078.2 8125.3 7059.7 7101.8 7296.3 7316.1 7451.0 4704.6 4801.7 4806.5 4902.6 4913.0 2013.1 2056.5 2084.5 2085.5 2138.3 839.7 889.3 889.6 902.6 967.3 16753.7 16848.2 16967.3 18288.3 19368.4 858.4 895.8 908.4 918.3 919.9 9831.5 10197.5 10426.4 10529.5 10653.1 442941.0 443697.0 453092.0 460675.0 472807.0 92428.5 93324.0 93589.5 93685.0 93760.5 910.6 938.6 970.1 994.9 999.8 15341.9 16063.9 16159.5 16450.0 16967.7 42223.4 42764.8 42865.8 43377.0 44371.1 53745.7 54471.5 57125.7 57448.4 58773.0 8713.3 8866.6 8910.5 8958.5 8984.6 8281.7 9296.8 11040.9 11576.9 12211.6 11107.4 11276.6 11344.5 11362.9 11635.8 10616.0 10961.1 10961.6 10995.0 11402.4 11027.4 11048.8 11081.3 11222.6 11253.7 8494.4 8902.6 8965.9 8970.8 8995.1 10342.7 10757.3 11027.5 11028.5 11801.1 12:33:18 INFO - PROCESS | 19051 | 12:33:18 INFO - PROCESS | 19051 | [#3] mootools.html Cycles:180 Average:5896.51 Median:5128.05 stddev:3367.82 (65.7%) stddev-sans-first:3359.72 12:33:18 INFO - PROCESS | 19051 | Values: 1321.9 1336.6 1379.5 1524.8 1548.4 8460.6 9070.7 9079.3 9084.0 9101.6 7819.1 8035.3 8049.1 8246.5 8886.0 2291.3 2368.0 2370.9 2381.3 2387.8 2408.9 2450.5 2475.8 2483.7 2488.9 2111.3 2175.6 2438.9 2463.1 2463.6 2364.3 2415.8 2429.5 2451.5 2459.1 2400.4 2411.2 2412.5 2418.1 2451.6 8889.9 8984.3 8986.8 8987.8 8999.2 5317.7 5485.6 5486.8 5489.6 5491.7 3020.5 3171.8 3256.5 3360.8 3361.5 1110.2 1147.5 1158.9 1188.9 1209.8 12790.6 12793.4 12799.8 12816.8 12830.1 4784.7 4797.9 4818.9 4834.9 4980.4 9670.6 9788.0 9806.0 9808.0 9819.8 5429.3 5431.5 5435.9 5436.1 5442.9 4926.9 4968.0 5014.4 5088.9 5091.3 3703.7 3716.8 3896.2 3910.3 3921.9 1142.4 1146.5 1169.3 1180.4 1196.9 866.6 880.3 880.6 901.8 916.0 6089.6 6230.2 6231.4 6329.0 6353.9 878.7 922.1 952.1 999.5 1027.7 4155.6 4237.0 4269.7 4364.5 4381.8 10863.8 11359.8 11367.0 11394.5 11398.3 11313.0 11346.0 11347.1 11348.3 11355.6 7797.0 8065.5 8066.6 8307.8 8319.0 5826.3 5836.4 5867.9 5968.0 6229.9 10378.4 10384.0 10423.6 10471.5 10518.3 10511.4 10528.2 10532.5 10582.9 10609.6 7956.4 8126.3 8128.3 8130.3 8136.8 8439.0 8514.1 8574.3 8581.4 8655.0 7782.5 7824.4 7867.0 7875.0 8068.4 7513.8 7666.4 7732.8 7914.4 7927.2 6856.3 6965.9 6971.9 6976.5 6979.0 5164.8 5190.1 5209.8 5212.8 5375.7 5433.7 5439.8 5470.8 5485.8 5626.5 12:33:18 INFO - PROCESS | 19051 | 12:33:18 INFO - PROCESS | 19051 | [#4] prototype.html Cycles:180 Average:4707.25 Median:5381.78 stddev:1354.96 (25.2%) stddev-sans-first:1318.64 12:33:18 INFO - PROCESS | 19051 | Values: 346.7 352.9 356.4 359.5 364.9 5235.2 5385.8 5423.1 5431.5 5433.4 5217.4 5263.6 5307.4 5332.8 5398.6 4198.7 4212.6 4223.6 4239.6 4330.8 4219.9 4263.1 4283.9 4302.0 4316.0 4236.0 4242.1 4242.6 4244.2 4254.6 4232.6 4233.9 4244.6 4245.7 4288.3 3638.5 3743.8 3761.3 3771.8 3829.8 5207.4 5228.8 5242.6 5244.8 5261.1 4844.1 4872.8 4882.0 4884.7 4902.9 5422.8 5458.4 5505.9 5555.3 5650.6 4117.4 4118.4 4119.4 4120.6 4121.6 5812.0 5863.5 5878.8 5893.4 5902.8 4133.0 4133.2 4217.0 4228.5 4236.8 4261.5 4266.2 4278.5 4279.8 4297.0 4824.4 4828.5 4852.7 4864.6 4885.7 5407.7 5623.6 5640.0 5661.0 5703.8 1361.6 1384.5 1397.5 1399.5 1438.3 948.4 958.3 980.3 981.4 988.8 5117.8 5141.7 5179.8 5180.5 5200.6 5525.6 5527.6 5527.7 5530.4 5545.4 5164.4 5181.4 5195.7 5216.3 5395.0 2889.5 2959.7 2960.6 2963.8 2979.2 5784.3 5785.2 5794.8 5798.8 5833.2 5535.6 5637.5 5657.9 5679.8 5715.6 5700.3 5747.1 5751.7 5790.4 5838.2 5377.8 5558.6 5625.3 5657.0 5685.8 5522.5 5526.8 5549.4 5566.3 5582.4 5793.4 5807.0 5837.8 5849.3 5854.8 3995.7 4123.7 4138.5 4163.6 4169.9 5511.3 5614.6 5619.8 5640.3 5678.5 5485.8 5587.4 5590.2 5619.0 5631.4 5570.2 5608.6 5643.9 5650.6 5654.7 5373.7 5587.7 5602.4 5608.4 5624.8 5633.6 5642.5 5672.4 5699.6 5712.8 5436.8 5531.4 5553.6 5558.2 5559.6 12:33:18 INFO - PROCESS | 19051 | 12:33:18 INFO - PROCESS | 19051 | [#5] yui.html Cycles:180 Average:16334.26 Median:470.09 stddev:22227.24 (4728.3%) stddev-sans-first:22258.32 12:33:18 INFO - PROCESS | 19051 | Values: 631.3 661.8 670.5 682.6 701.8 12575.2 12743.7 12794.9 12838.5 12840.4 11316.8 11395.0 11405.8 11416.8 11440.6 528.1 542.6 600.9 627.1 636.6 612.9 613.9 614.5 614.6 614.8 669.4 674.3 674.5 674.7 674.8 664.5 671.5 672.5 673.2 674.2 466.0 467.8 469.8 470.4 470.8 11223.8 11279.3 11299.1 11344.7 11367.5 12050.6 12119.6 12732.7 12751.3 12944.2 10165.6 10511.5 10684.4 10735.1 10766.7 3543.1 3543.2 3618.2 3631.0 3681.8 62625.7 62988.0 63095.7 65169.7 65558.0 8936.8 9034.8 9177.6 9389.5 9550.7 15062.1 15198.3 15270.2 15542.5 15692.9 7172.0 7235.7 7329.1 7424.8 7585.8 4285.9 4405.2 4405.8 4421.8 4439.4 2918.9 3041.9 3044.6 3046.8 3049.3 531.2 531.6 536.9 559.3 560.4 589.3 624.2 645.7 664.1 667.1 8417.5 8880.2 9016.9 9067.9 9100.6 687.9 690.3 693.2 716.5 724.3 4255.1 4304.1 4357.6 4373.2 4434.5 79526.6 84451.0 88353.6 88827.0 90462.0 47949.8 48252.3 48451.0 61128.7 79613.2 67139.0 67280.0 67362.3 67463.0 67887.0 8360.5 8476.9 8536.0 8574.6 8627.2 31872.8 42509.0 45562.8 48790.5 51234.0 58188.7 58575.4 59852.7 61146.0 61657.4 10800.6 10899.9 11233.9 11281.5 11559.5 13259.3 13504.3 13519.3 13899.9 14418.9 11401.1 11656.1 12041.0 12082.2 12146.3 11413.6 11782.9 11862.2 12034.2 12148.6 11162.9 11164.5 11174.6 11284.8 11716.2 10102.9 10232.5 10347.2 10405.6 10705.5 10094.0 10419.5 10429.9 10473.8 10483.7 12:33:18 INFO - PROCESS | 19051 | -------- Summary: end -------- 12:33:18 INFO - PROCESS | 19051 | 12:33:18 INFO - TEST-INFO | 19051: exit 0 12:33:18 INFO - TEST-OK | dromaeo_css | took 1114699ms 12:33:18 INFO - TEST-START | kraken 12:33:18 INFO - operating with platform_type : linux_ 12:33:18 INFO - Initialising browser for kraken test... 12:33:18 INFO - TEST-INFO | started process 19357 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppWkAUY/profile http://localhost:38523/getInfo.html) 12:33:22 INFO - PROCESS | 19357 | __metrics Screen width/height:1600/1200 12:33:22 INFO - PROCESS | 19357 | colorDepth:24 12:33:22 INFO - PROCESS | 19357 | Browser inner width/height: 1024/697 12:33:22 INFO - PROCESS | 19357 | __metrics 12:33:23 INFO - PROCESS | 19357 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:33:23 INFO - PROCESS | 19357 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:33:23 INFO - PROCESS | 19357 | console.error: PushService: 12:33:23 INFO - PROCESS | 19357 | stateChangeProcessEnqueue: Error transitioning state 12:33:23 INFO - PROCESS | 19357 | UnknownError 12:33:24 INFO - TEST-INFO | 19357: exit 0 12:33:24 INFO - Browser initialized. 12:33:24 INFO - Running cycle 1/1 for kraken test... 12:33:24 INFO - TEST-INFO | started process 19449 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppWkAUY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:33:36 INFO - PROCESS | 19449 | RSS: Main: 144752640 12:33:36 INFO - PROCESS | 19449 | 12:33:38 INFO - PROCESS | 19449 | Cycle 1(1): loaded http://localhost:38523/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38523/tests/kraken/driver.html?testName=audio-beat-detection) 12:33:39 INFO - PROCESS | 19449 | RSS: Main: 186171392 12:33:39 INFO - PROCESS | 19449 | 12:33:42 INFO - PROCESS | 19449 | Cycle 1(1): loaded http://localhost:38523/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38523/tests/kraken/driver.html?testName=audio-dft) 12:33:42 INFO - PROCESS | 19449 | RSS: Main: 175767552 12:33:42 INFO - PROCESS | 19449 | 12:33:45 INFO - PROCESS | 19449 | Cycle 1(1): loaded http://localhost:38523/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38523/tests/kraken/driver.html?testName=audio-fft) 12:33:46 INFO - PROCESS | 19449 | RSS: Main: 266534912 12:33:46 INFO - PROCESS | 19449 | 12:33:48 INFO - PROCESS | 19449 | Cycle 1(1): loaded http://localhost:38523/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38523/tests/kraken/driver.html?testName=audio-oscillator) 12:33:48 INFO - PROCESS | 19449 | RSS: Main: 174198784 12:33:48 INFO - PROCESS | 19449 | 12:33:50 INFO - PROCESS | 19449 | Cycle 1(1): loaded http://localhost:38523/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38523/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:33:51 INFO - PROCESS | 19449 | RSS: Main: 176005120 12:33:51 INFO - PROCESS | 19449 | 12:33:54 INFO - PROCESS | 19449 | Cycle 1(1): loaded http://localhost:38523/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38523/tests/kraken/driver.html?testName=imaging-darkroom) 12:33:54 INFO - PROCESS | 19449 | RSS: Main: 215056384 12:33:54 INFO - PROCESS | 19449 | 12:33:58 INFO - PROCESS | 19449 | Cycle 1(1): loaded http://localhost:38523/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38523/tests/kraken/driver.html?testName=imaging-desaturate) 12:33:58 INFO - PROCESS | 19449 | RSS: Main: 213184512 12:33:58 INFO - PROCESS | 19449 | 12:34:01 INFO - PROCESS | 19449 | Cycle 1(1): loaded http://localhost:38523/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38523/tests/kraken/driver.html?testName=json-parse-financial) 12:34:02 INFO - PROCESS | 19449 | RSS: Main: 212602880 12:34:02 INFO - PROCESS | 19449 | 12:34:03 INFO - PROCESS | 19449 | Cycle 1(1): loaded http://localhost:38523/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38523/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:34:04 INFO - PROCESS | 19449 | RSS: Main: 174579712 12:34:04 INFO - PROCESS | 19449 | 12:34:05 INFO - PROCESS | 19449 | Cycle 1(1): loaded http://localhost:38523/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38523/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:34:06 INFO - PROCESS | 19449 | RSS: Main: 181673984 12:34:06 INFO - PROCESS | 19449 | 12:34:08 INFO - PROCESS | 19449 | Cycle 1(1): loaded http://localhost:38523/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38523/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:34:08 INFO - PROCESS | 19449 | RSS: Main: 187895808 12:34:08 INFO - PROCESS | 19449 | 12:34:11 INFO - PROCESS | 19449 | Cycle 1(1): loaded http://localhost:38523/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38523/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:34:12 INFO - PROCESS | 19449 | RSS: Main: 196501504 12:34:12 INFO - PROCESS | 19449 | 12:34:14 INFO - PROCESS | 19449 | Cycle 1(1): loaded http://localhost:38523/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38523/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:34:15 INFO - PROCESS | 19449 | RSS: Main: 192778240 12:34:15 INFO - PROCESS | 19449 | 12:34:17 INFO - PROCESS | 19449 | Cycle 1(1): loaded http://localhost:38523/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38523/tests/kraken/driver.html?testName=ai-astar) 12:34:17 INFO - PROCESS | 19449 | RSS: Main: 244690944 12:34:17 INFO - PROCESS | 19449 | 12:34:17 INFO - PROCESS | 19449 | __start_tp_report 12:34:17 INFO - PROCESS | 19449 | _x_x_mozilla_page_load 12:34:17 INFO - PROCESS | 19449 | _x_x_mozilla_page_load_details 12:34:17 INFO - PROCESS | 19449 | |i|pagename|runs| 12:34:17 INFO - PROCESS | 19449 | |0;ai-astar;104;111;110;110;110;110;111;110;109;110 12:34:17 INFO - PROCESS | 19449 | |1;audio-beat-detection;153;121;119;155;124;124;118;118;156;118 12:34:17 INFO - PROCESS | 19449 | |2;audio-dft;160;160;159;160;159;159;159;160;161;159 12:34:17 INFO - PROCESS | 19449 | |3;audio-fft;74;75;76;107;77;76;77;76;98;75 12:34:17 INFO - PROCESS | 19449 | |4;audio-oscillator;83;81;117;81;82;82;100;82;81;118 12:34:17 INFO - PROCESS | 19449 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;116;116;116 12:34:17 INFO - PROCESS | 19449 | |6;imaging-darkroom;147;146;146;145;146;146;146;146;147;145 12:34:17 INFO - PROCESS | 19449 | |7;imaging-desaturate;84;85;84;84;85;85;85;85;85;85 12:34:17 INFO - PROCESS | 19449 | |8;json-parse-financial;51;51;50;52;51;50;53;51;52;50 12:34:17 INFO - PROCESS | 19449 | |9;json-stringify-tinderbox;59;59;59;59;60;60;61;59;59;59 12:34:17 INFO - PROCESS | 19449 | |10;stanford-crypto-aes;74;76;73;74;74;74;75;75;82;74 12:34:17 INFO - PROCESS | 19449 | |11;stanford-crypto-ccm;123;126;123;122;121;121;119;123;174;122 12:34:17 INFO - PROCESS | 19449 | |12;stanford-crypto-pbkdf2;154;154;155;155;159;156;155;157;159;158 12:34:17 INFO - PROCESS | 19449 | |13;stanford-crypto-sha256-iterative;62;62;67;64;66;63;62;63;66;63 12:34:17 INFO - PROCESS | 19449 | __end_tp_report 12:34:17 INFO - PROCESS | 19449 | __start_cc_report 12:34:17 INFO - PROCESS | 19449 | _x_x_mozilla_cycle_collect,1573 12:34:17 INFO - PROCESS | 19449 | __end_cc_report 12:34:17 INFO - PROCESS | 19449 | __startTimestamp1487018057395__endTimestamp 12:34:17 INFO - PROCESS | 19449 | 12:34:17 INFO - PROCESS | 19449 | ------- Summary: start ------- 12:34:17 INFO - PROCESS | 19449 | Number of tests: 14 12:34:17 INFO - PROCESS | 19449 | 12:34:17 INFO - PROCESS | 19449 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:2.01 (1.8%) stddev-sans-first:0.60 12:34:17 INFO - PROCESS | 19449 | Values: 104.0 111.0 110.0 110.0 110.0 110.0 111.0 110.0 109.0 110.0 12:34:17 INFO - PROCESS | 19449 | 12:34:17 INFO - PROCESS | 19449 | [#1] audio-beat-detection Cycles:10 Average:130.60 Median:124.00 stddev:16.77 (13.5%) stddev-sans-first:15.71 12:34:17 INFO - PROCESS | 19449 | Values: 153.0 121.0 119.0 155.0 124.0 124.0 118.0 118.0 156.0 118.0 12:34:17 INFO - PROCESS | 19449 | 12:34:17 INFO - PROCESS | 19449 | [#2] audio-dft Cycles:10 Average:159.60 Median:160.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 12:34:17 INFO - PROCESS | 19449 | Values: 160.0 160.0 159.0 160.0 159.0 159.0 159.0 160.0 161.0 159.0 12:34:17 INFO - PROCESS | 19449 | 12:34:17 INFO - PROCESS | 19449 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:11.51 (15.1%) stddev-sans-first:11.92 12:34:17 INFO - PROCESS | 19449 | Values: 74.0 75.0 76.0 107.0 77.0 76.0 77.0 76.0 98.0 75.0 12:34:17 INFO - PROCESS | 19449 | 12:34:17 INFO - PROCESS | 19449 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:81.50 stddev:15.25 (18.7%) stddev-sans-first:15.91 12:34:17 INFO - PROCESS | 19449 | Values: 83.0 81.0 117.0 81.0 82.0 82.0 100.0 82.0 81.0 118.0 12:34:17 INFO - PROCESS | 19449 | 12:34:17 INFO - PROCESS | 19449 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 12:34:17 INFO - PROCESS | 19449 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 116.0 12:34:17 INFO - PROCESS | 19449 | 12:34:17 INFO - PROCESS | 19449 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 12:34:17 INFO - PROCESS | 19449 | Values: 147.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 147.0 145.0 12:34:17 INFO - PROCESS | 19449 | 12:34:17 INFO - PROCESS | 19449 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 12:34:17 INFO - PROCESS | 19449 | Values: 84.0 85.0 84.0 84.0 85.0 85.0 85.0 85.0 85.0 85.0 12:34:17 INFO - PROCESS | 19449 | 12:34:17 INFO - PROCESS | 19449 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.00 stddev:0.99 (1.9%) stddev-sans-first:1.05 12:34:17 INFO - PROCESS | 19449 | Values: 51.0 51.0 50.0 52.0 51.0 50.0 53.0 51.0 52.0 50.0 12:34:17 INFO - PROCESS | 19449 | 12:34:17 INFO - PROCESS | 19449 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 12:34:17 INFO - PROCESS | 19449 | Values: 59.0 59.0 59.0 59.0 60.0 60.0 61.0 59.0 59.0 59.0 12:34:17 INFO - PROCESS | 19449 | 12:34:17 INFO - PROCESS | 19449 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:74.50 stddev:2.56 (3.4%) stddev-sans-first:2.68 12:34:17 INFO - PROCESS | 19449 | Values: 74.0 76.0 73.0 74.0 74.0 74.0 75.0 75.0 82.0 74.0 12:34:17 INFO - PROCESS | 19449 | 12:34:17 INFO - PROCESS | 19449 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:123.00 stddev:16.47 (13.4%) stddev-sans-first:17.40 12:34:17 INFO - PROCESS | 19449 | Values: 123.0 126.0 123.0 122.0 121.0 121.0 119.0 123.0 174.0 122.0 12:34:17 INFO - PROCESS | 19449 | 12:34:17 INFO - PROCESS | 19449 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.20 Median:156.50 stddev:1.93 (1.2%) stddev-sans-first:1.88 12:34:17 INFO - PROCESS | 19449 | Values: 154.0 154.0 155.0 155.0 159.0 156.0 155.0 157.0 159.0 158.0 12:34:17 INFO - PROCESS | 19449 | 12:34:17 INFO - PROCESS | 19449 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.50 stddev:1.87 (3.0%) stddev-sans-first:1.87 12:34:17 INFO - PROCESS | 19449 | Values: 62.0 62.0 67.0 64.0 66.0 63.0 62.0 63.0 66.0 63.0 12:34:17 INFO - PROCESS | 19449 | -------- Summary: end -------- 12:34:17 INFO - PROCESS | 19449 | 12:34:18 INFO - TEST-INFO | 19449: exit 0 12:34:18 INFO - TEST-OK | kraken | took 59553ms 12:34:18 INFO - SUITE-END | took 1174s 12:34:18 INFO - Completed test suite (00:19:34) 12:34:18 INFO - javascript benchmark 12:34:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3139.748820094392, 3186.904392868213, 3188.346388990256, 3209.406259841931, 3230.370077834823, 5477.123660214362, 5507.173923911415, 5539.501444869961, 5557.0, 5581.693006884625, 5565.749541270642, 5596.916046259309, 5600.775968961247, 5601.0, 5604.579656525756, 5028.974855125728, 5049.747512624373, 5084.211947148198, 5111.412187598418, 5132.666376685522, 4948.480409556981, 4950.9257361139435, 4973.626977976648, 5084.415292241402, 5138.691678499284, 5021.698698078127, 5080.110980578403, 5084.491550844905, 5104.081265372231, 5113.437521872591, 5095.108356037697, 5098.694078355274, 5106.69359838409, 5114.616403769695, 5128.71792051437, 4882.292067650171, 4931.137051016058, 4951.529604687549, 5006.549410553068, 5013.197888337849, 5421.484958928895, 5442.074847275972, 5443.5100840924115, 5490.780368785244, 5539.279893613845, 5925.20009798676, 5930.1401296812155, 5935.317438494542, 5941.910871336933, 5948.881022379572, 5741.655500669973, 5818.389069147721, 5894.882102357972, 5900.557458190653, 5952.9107063394085, 5472.863178420532, 5506.531944784698, 5510.008198524264, 5513.7794488220825, 5537.750801213955, 6030.517558595302, 6039.698015099228, 6041.154238406627, 6041.818745437644, 6073.210482637229, 5698.515626171822, 5751.022326204556, 5827.504662103684, 5832.0, 5832.795852145239, 5839.591228613956, 5855.970720146372, 5872.911906321408, 5893.970530147321, 5913.881722365529, 5874.823755287348, 5878.853028674232, 5882.676452795052, 5886.117082437669, 5888.087346461305, 5841.591088623755, 5886.941130588725, 5888.499477544457, 5890.6171098879295, 5911.438413350725, 4328.913421731548, 4344.413504176959, 4399.186150562156, 4401.955980440219, 4410.757408342508, 3926.960730392717, 3934.429507721364, 3943.329633962176, 3966.722329436912, 3966.861159859391, 5565.666060036411, 5610.354809196913, 5615.747291371898, 5618.157276408571, 5645.068563686946, 5781.53747700183, 5805.88388232233, 5863.589548731547, 5878.030125029322, 5950.583459157904, 5567.47109024642, 5595.552355811526, 5612.045952188138, 5619.578531610146, 5648.576356773258, 5104.387473503203, 5120.18077107661, 5122.282880396748, 5123.410807757081, 5147.510986456281, 5883.264591926009, 5946.583739138218, 6095.542834287357, 6157.076438534255, 6172.382761723792, 5970.283565972111, 6011.0382338825575, 6013.278406591237, 6015.608985415934, 6039.728212230548, 6192.052484160345, 6210.937890621217, 6227.314995350417, 6229.3770622939155, 6231.53263505248, 5612.971935140298, 5649.519790817826, 5808.651480911159, 5903.144044113666, 5943.821685349447, 5865.354810970704, 5932.347441781487, 5935.673537955454, 5950.761969521171, 5969.044952807703, 5737.5983681141915, 5750.396208398225, 5779.479846813807, 5784.739686714192, 5789.363170051207, 5642.774289028557, 5724.885502290014, 5777.768889244383, 5791.507721843691, 5797.971010144923, 5619.409961954099, 5664.348599911063, 5682.659040457585, 5727.255456790591, 5755.798547050833, 5763.077907534775, 5780.768769249351, 5803.593748437569, 5806.042003069615, 5808.186853840551, 5529.281193444826, 5566.22072909801, 5586.720663966867, 5678.545716342765, 5699.116636921284], "value": 5439.327433987832, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.1457741265253, 583.891979983703, 602.8372339468343, 605.3643674142147, 623.4326762645993, 30166.24584385389, 36642.63357366426, 37568.81215593918, 37633.43549846748, 37914.810425947864, 41229.38155927663, 41678.0, 41709.16581668365, 41759.37360939589, 41769.373459398055, 8177.9182208178045, 8381.07808141104, 8676.609552570118, 8858.822823543525, 8866.335024873128, 10357.637482688107, 10648.41433721145, 10672.199585031114, 10860.511276992514, 10888.455577221108, 10660.147188224963, 10694.679159625224, 10756.78486430271, 10761.677149685522, 10762.085222756075, 10624.946875265652, 10662.093722033636, 10685.519151638116, 10689.0, 10690.465476726133, 10584.841227381596, 10649.148068154607, 10662.413567253798, 10663.360198388122, 10678.038976492153, 37489.0, 37553.812230938944, 37564.812175939216, 37721.24557508862, 37736.622633773586, 3357.5635167428077, 3408.727301815849, 3466.0814884055744, 3629.310431018098, 3691.335559599271, 28395.716042839515, 28782.280442988882, 28870.42259154826, 28989.56515652267, 29013.709862901313, 3598.334308153, 3611.530501034849, 3622.9275414491826, 3647.781133131994, 3671.1739858531882, 333447.0, 334364.0, 334718.99999999756, 334866.0, 336111.0, 33442.66557334444, 35466.29067418637, 54012.45987540153, 55130.0, 55850.0, 35706.64293357033, 36251.63748362535, 36268.637313627056, 36338.63661363405, 36693.44959825605, 14199.71600567983, 14200.928995355163, 14203.715925681428, 14208.715825683428, 14239.145651260958, 11095.44522773858, 11454.828177577343, 11727.824082638766, 11873.228240164362, 12007.279563226235, 8453.112423195598, 8470.745877623682, 8529.189726975927, 8560.0, 8572.271356934605, 3220.85506152219, 3240.7893486923276, 3284.1625385527013, 3305.6694330567234, 3326.0542582588973, 845.8984921809422, 850.3324889961351, 900.7748062984253, 933.5332333833084, 937.4843835890233, 27355.86322068377, 27788.988181032142, 28542.85728571344, 28554.428911421655, 29038.564421533694, 992.1080051649361, 998.1515711645044, 1017.3844823881593, 1026.4918865161792, 1046.5918291866178, 13201.73596528064, 15024.774628380583, 16215.0, 16321.0, 16560.337586496647, 529851.0, 532390.0, 533916.0, 535414.0, 536684.0, 49801.50198497969, 49892.50107498879, 50006.74996624994, 50030.49969500331, 50084.499155008714, 1136.494260054268, 1187.3469591724518, 1218.524775337619, 1270.1807334269345, 1277.1060257819563, 27416.725832741417, 28623.284417888888, 29107.417851643273, 29580.704192957794, 30283.848580756956, 43047.139057219305, 51598.48401515937, 52896.471035289156, 53091.0, 54873.725631371584, 379457.0, 382941.0, 383065.0, 383201.0, 383598.0, 33641.49537756887, 34755.652443476254, 34762.0, 36406.453903190944, 39088.0, 40256.798716007404, 41382.0, 41743.1651366977, 42470.575294246664, 43102.78448607737, 35393.469097964065, 35468.46797298094, 35502.8224858874, 35633.82183089068, 35972.64027359693, 36326.27347453089, 36537.81731091434, 37167.6283237175, 37418.625813742605, 38062.0, 36040.0, 36078.0, 36255.0, 36491.0, 36641.81679091587, 31437.52843707392, 34144.14639634029, 34488.310233794684, 34522.482162767075, 34604.0, 25047.248582542554, 25834.741652583234, 26046.609300860124, 26062.0, 26504.0], "value": 18033.633015713494, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.6181960768641, 387.901085223268, 401.34981330245006, 408.3079180788563, 417.3801904172304, 14187.219702916336, 14532.418703251857, 16806.243719032642, 17886.821131788696, 17934.5516362091, 14694.853051469481, 17032.0, 17073.231704573293, 17303.0, 17357.82642173578, 5805.12923061541, 6015.939840601582, 6023.247094113236, 6026.367231440701, 6033.09503574463, 5642.802501912434, 5875.676837773921, 5896.056630939051, 5907.320658124307, 5909.645421274738, 5678.375378708339, 5831.883362332772, 5868.559858010645, 5877.735501902424, 5879.382664820197, 5871.6183448075735, 5875.1187321901625, 5887.911681324784, 5905.645661260338, 5906.468417842415, 5265.394479634852, 5398.379186393576, 5400.891982160335, 5402.459754024566, 5487.2317875497465, 14109.78835317471, 14379.856201437957, 14384.0, 14402.495912643111, 20305.289314874055, 2474.81438892082, 2496.750324967507, 2517.4587463695393, 2530.4559519703166, 2691.3944362518278, 9617.182539484153, 10185.643502477378, 10206.795864082676, 10588.205884558613, 10629.04338609521, 2002.3092033248506, 2024.3926821953355, 2026.118638392304, 2057.238821635989, 2108.3780284816016, 71971.64014179895, 73512.63243683802, 73801.26198737997, 82952.58523707403, 85963.0, 10434.68695939123, 10760.838587421194, 11025.44872756359, 11282.661520154408, 11294.774104517863, 16086.0, 16137.354505819636, 16148.111853847917, 16149.919250403673, 16170.353185872433, 7748.22517748232, 7928.7224947127725, 7982.182804035614, 8078.151794061657, 8125.268725814705, 7059.682314295869, 7101.751438699724, 7296.270372962767, 7316.122065352191, 7451.0, 4704.5765881070865, 4801.663883528189, 4806.49531799156, 4902.558769710743, 4913.0, 2013.1343522285558, 2056.4653190170366, 2084.4997200672033, 2085.5411809401908, 2138.3478039198194, 839.7102999465175, 889.2841262783521, 889.6174644902625, 902.6389444222364, 967.298708436378, 16753.748693769605, 16848.24182911772, 16967.321307147577, 18288.268469261347, 19368.4189474316, 858.3733874271817, 895.7984453498041, 908.40953380302, 918.2653876898588, 919.94480331179, 9831.508424578886, 10197.541110650038, 10426.426546540013, 10529.473526323653, 10653.147748180127, 442941.0, 443697.0, 453092.0, 460675.0, 472807.0, 92428.53785731163, 93324.0, 93589.5320523393, 93685.0, 93760.53119734494, 910.6402970826487, 938.5729493080632, 970.1123472023161, 994.8607194992707, 999.820032394176, 15341.923290383924, 16063.91968040199, 16159.515214543113, 16450.0, 16967.745483817507, 42223.366649500895, 42764.78617606892, 42865.78567107269, 43377.0, 44371.11257774762, 53745.73127134339, 54471.45528544664, 57125.71437142788, 57448.42551574598, 58773.0, 8713.30293576525, 8866.556672166495, 8910.465372077697, 8958.462492250486, 8984.550772461482, 8281.668733250603, 9296.767580810534, 11040.889591103985, 11576.88423115758, 12211.572594959134, 11107.44462776874, 11276.565128291553, 11344.546218151181, 11362.886371136514, 11635.767284654428, 10616.0, 10961.123110151328, 10961.616343427942, 10995.0, 11402.429878505876, 11027.44862756875, 11048.834267485834, 11081.335119892832, 11222.607208747655, 11253.71865703364, 8494.447860889022, 8902.59938302765, 8965.865512017455, 8970.775730606527, 8995.100489950952, 10342.689719308433, 10757.30077544957, 11027.503762330874, 11028.5037173329, 11801.114916381477], "value": 8878.95104369239, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.9008574356922, 1336.6123824091014, 1379.5447502324234, 1524.7865298858155, 1548.3806477409041, 8460.619272132753, 9070.727878163649, 9079.273658107351, 9084.046175151612, 9101.59042843072, 7819.100803407609, 8035.316998055172, 8049.07435644901, 8246.505209687422, 8885.95557022214, 2291.2667946257206, 2368.0409434179187, 2370.8696021718797, 2381.333226696519, 2387.797037251827, 2408.8795560222006, 2450.4853980664084, 2475.801935845137, 2483.7143728471187, 2488.850668959859, 2111.250506070346, 2175.575762726269, 2438.926832195028, 2463.1255904154036, 2463.581191197492, 2364.290712786166, 2415.842970206931, 2429.453372991072, 2451.460678650712, 2459.139301244568, 2400.447896983686, 2411.216354684717, 2412.541617092747, 2418.1415597462824, 2451.644511545816, 8889.911100889038, 8984.326175536795, 8986.820263594756, 8987.820243595157, 8999.19007289347, 5317.707526086064, 5485.561155107582, 5486.753096110685, 5489.64317319373, 5491.7254137292975, 3020.5318175682805, 3171.809691418522, 3256.544083828266, 3360.8487618057247, 3361.4957756336503, 1110.1840147491587, 1147.512307269407, 1158.8841115888429, 1188.9227200232044, 1209.818527220924, 12790.552330668383, 12793.424295906707, 12799.808002879965, 12816.80774788379, 12830.101892867502, 4784.6889952153, 4797.928031079537, 4818.927716084261, 4834.854954351375, 4980.377452818398, 9670.613175473043, 9788.0, 9805.950970245245, 9808.0, 9819.75450613726, 5429.321334833146, 5431.456854314616, 5435.918461223085, 5436.130219164915, 5442.8911421771345, 4926.8768280793265, 4968.0, 5014.423341315723, 5088.872778180576, 5091.261767043832, 3703.666669999659, 3716.7769933804057, 3896.1818018215927, 3910.3156947534067, 3921.9019524512114, 1142.3602782441692, 1146.5471138900255, 1169.2867350915935, 1180.4333919718583, 1196.8862958018974, 866.6316815353575, 880.3089574683843, 880.6345366672759, 901.8466860633577, 916.0015583014546, 6089.5737298388685, 6230.158928544679, 6231.40801623845, 6328.968355158195, 6353.904691429632, 878.7319867440365, 922.087133737595, 952.1288021460286, 999.4552968632113, 1027.712240572641, 4155.605217504332, 4236.957630423718, 4269.658427325807, 4364.54172311909, 4381.824727010884, 10863.83704244437, 11359.829602555968, 11367.033802126913, 11394.48724807369, 11398.316101033965, 11313.0, 11346.0, 11347.148963827582, 11348.319100853974, 11355.602553910574, 7796.961015195001, 8065.516069035877, 8066.556339401389, 8307.792305192297, 8318.958405207935, 5826.271716035496, 5836.358000620014, 5867.882642347044, 5968.0, 6229.875402492015, 10378.377297362182, 10384.0, 10423.583056677951, 10471.476426178813, 10518.263721539724, 10511.369317840954, 10528.210384221367, 10532.52603632823, 10582.894171058191, 10609.575616975235, 7956.403269754907, 8126.309263712415, 8128.3497320213055, 8130.268275855202, 8136.75589732309, 8439.0, 8514.063453020286, 8574.31405487572, 8581.35639827003, 8655.04794472595, 7782.455228133977, 7824.374050076094, 7866.960665196638, 7875.0, 8068.435209535511, 7513.812154695957, 7666.425018123551, 7732.8453430932195, 7914.44598878073, 7927.246911543394, 6856.314368563104, 6965.860682786417, 6971.930280697128, 6976.5465244758925, 6978.965105174441, 5164.845054648216, 5190.117679994485, 5209.817656382009, 5212.843614691566, 5375.6774593524515, 5433.701146436984, 5439.782408703766, 5470.808521701881, 5485.780568777204, 5626.524473885104], "value": 4692.18012968282, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.6897127071271, 352.8623836703686, 356.3710051758646, 359.5164503742466, 364.8595290813036, 5235.214717792333, 5385.78456861725, 5423.132298832183, 5431.4568543145715, 5433.402325744165, 5217.399999000116, 5263.578913686905, 5307.389650190229, 5332.840014799553, 5398.64908780929, 4198.6641068714425, 4212.620864122236, 4223.577642235782, 4239.576042395766, 4330.826766929335, 4219.894502637428, 4263.104748002923, 4283.907603561088, 4301.978490107545, 4315.978420107895, 4236.0, 4242.109157077018, 4242.639375653073, 4244.236037513247, 4254.595813397737, 4232.582085001528, 4233.936490952638, 4244.575542445777, 4245.6815738819405, 4288.270993931039, 3638.5263968092963, 3743.7753734776, 3761.2665530221616, 3771.7548359356556, 3829.8468061277517, 5207.427183009866, 5228.843134705965, 5242.55438287746, 5244.81643142492, 5261.105612045923, 4844.128056949748, 4872.756362181876, 4881.975590122062, 4884.682495637772, 4902.926456103161, 5422.783088676449, 5458.372287186985, 5505.917411238835, 5555.250041244421, 5650.604457687963, 4117.444145040411, 4118.361653943613, 4119.423280740669, 4120.608542188487, 4121.5878412158845, 5811.970940145315, 5863.472287494146, 5878.794242201502, 5893.410658934073, 5902.763889444417, 4133.026233372999, 4133.23535145999, 4217.0, 4228.513720922072, 4236.788160591958, 4261.509926358509, 4266.189424009428, 4278.465191851019, 4279.764612946318, 4296.978515107467, 4824.372831531879, 4828.5412885775795, 4852.684575502581, 4864.610831133501, 4885.682430641997, 5407.729183641841, 5623.578231632644, 5640.0, 5660.97169514158, 5703.800366987219, 1361.5642994241748, 1384.536180379584, 1397.5108711950736, 1399.4751968011994, 1438.26648409312, 948.393028461785, 958.2908647600865, 980.2892902645525, 981.4111533080095, 988.7824678570703, 5117.795288188505, 5141.691498510027, 5179.766910488962, 5180.507851754077, 5200.609954253446, 5525.557955363562, 5527.585431092603, 5527.723613819293, 5530.446955304518, 5545.390007099216, 5164.3802743671, 5181.4041385240425, 5195.7142357170715, 5216.321878155892, 5395.0, 2889.515017085305, 2959.733623973853, 2960.6299212598424, 2963.8369889655846, 2979.2105092150596, 5784.334801497797, 5785.247917770663, 5794.768209271582, 5798.82603521895, 5833.241678581842, 5535.616095976006, 5637.46444087811, 5657.9249942511615, 5679.829605111853, 5715.628484148517, 5700.287464066992, 5747.137929310553, 5751.654900705971, 5790.420957904176, 5838.241028666162, 5377.784888604569, 5558.638688485397, 5625.324961004542, 5656.971715141398, 5685.77256909719, 5522.502974732132, 5526.834194974157, 5549.361823390362, 5566.276384070045, 5582.358028826737, 5793.36273009977, 5807.0, 5837.795677151449, 5849.268841394825, 5854.824355269348, 3995.7003224757677, 4123.731957422758, 4138.544760076329, 4163.625273725379, 4169.8957526062095, 5511.283533140666, 5614.550835933034, 5619.80827477276, 5640.266765320482, 5678.488935995781, 5485.793125512381, 5587.413321601336, 5590.161475778666, 5618.971905140448, 5631.408702086222, 5570.2480165177185, 5608.635438696471, 5643.943560564342, 5650.576206784425, 5654.738104758129, 5373.704446255493, 5587.720613969366, 5602.431319230622, 5608.355039170385, 5624.831255062355, 5633.577481688972, 5642.492175704207, 5672.405351665165, 5699.632088298696, 5712.800311934374, 5436.794649787984, 5531.419200983839, 5553.555715542828, 5558.249636299048, 5559.554515825996], "value": 4279.0900486126575, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.3055638797322, 661.8477750117474, 670.4502308107354, 682.5529278322697, 701.8070030741549, 12575.18261313014, 12743.681407964805, 12794.872051279484, 12838.486460541579, 12840.35798210088, 11316.830247546293, 11395.0, 11405.771884562304, 11416.771664566724, 11440.599579014735, 528.1496790167827, 542.6282996147652, 600.9338972713009, 627.0656721485, 636.5639536917226, 612.9387061293879, 613.8956377415827, 614.5452365249705, 614.6342925959048, 614.7540983606549, 669.4276393683404, 674.3256743256743, 674.4806498995771, 674.6660403100473, 674.8414122681166, 664.4617859533793, 671.4628297362091, 672.5292295393219, 673.1686367336335, 674.2280089297751, 465.96505262105137, 467.7661169415292, 469.77216050215617, 470.3978906999047, 470.82814772608094, 11223.831642525369, 11279.32324060559, 11299.096072314194, 11344.659660210207, 11367.488463019185, 12050.638480845588, 12119.636410907688, 12732.681682957907, 12751.298678572675, 12944.15862968904, 10165.59337626494, 10511.52698128586, 10684.358938463716, 10735.087517561016, 10766.676999689944, 3543.1496440854266, 3543.2204914918675, 3618.2039951210954, 3630.981845090784, 3681.7606855554573, 62625.686871565806, 62988.0, 63095.738085238496, 65169.67415162894, 65558.0, 8936.776580585538, 9034.819303613891, 9177.587008584629, 9389.530523473799, 9550.665726699532, 15062.096274223582, 15198.316075776616, 15270.160141192118, 15542.456014039455, 15692.92153539225, 7171.964140179266, 7235.710571577183, 7329.120505539263, 7424.777256682308, 7585.848283034308, 4285.892852678708, 4405.207062728676, 4405.823767049282, 4421.756803375845, 4439.445069366329, 2918.8978385756823, 3041.9391612167633, 3044.6498652655227, 3046.84765761711, 3049.268175637831, 531.2482836785905, 531.6252042310163, 536.919462080691, 559.295287937194, 560.4255637971112, 589.3016775121495, 624.2446639566085, 645.6997496164212, 664.1134085995154, 667.0694381338103, 8417.494950303002, 8880.200781929529, 9016.909830901739, 9067.909320906838, 9100.590473428712, 687.9380855723009, 690.2786588015535, 693.2270518371979, 716.4948711158621, 724.3263764698776, 4255.085156691326, 4304.096139810612, 4357.629601483909, 4373.169097871394, 4434.467863856358, 79526.60236698779, 84451.0, 88353.55823220842, 88827.0, 90462.0, 47949.80125496891, 48252.27621585679, 48451.0, 61128.694356528824, 79613.20386796058, 67139.0, 67280.0, 67362.32637673561, 67462.98805517922, 67887.0, 8360.54017029045, 8476.92238997032, 8536.0, 8574.614142363484, 8627.180417860292, 31872.840635796674, 42509.0, 45562.772186138856, 48790.51209488002, 51234.0, 58188.70905645445, 58575.4142458587, 59852.70073649604, 61146.0, 61657.383426165165, 10800.612084206372, 10899.945500272448, 11233.887661123284, 11281.548738050386, 11559.479823407799, 13259.337033148497, 13504.324783760969, 13519.324033798073, 13899.930500347433, 14418.855811441752, 11401.144914131639, 11656.125790565571, 12041.0, 12082.154249202824, 12146.271223726251, 11413.60052398162, 11782.882171178178, 11862.22895511789, 12034.157608967289, 12148.635540933787, 11162.944185279022, 11164.49759760829, 11174.608888688857, 11284.774304514029, 11716.179867409199, 10102.89897101049, 10232.53953572106, 10347.223958203014, 10405.635802746867, 10705.518251678537, 10094.0, 10419.53112109972, 10429.895701042893, 10473.842892356468, 10483.737906552396], "value": 6316.6571735573025, "unit": "score"}], "name": "dromaeo_css", "value": 6926.925106042108, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 109.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 121.0, 119.0, 155.0, 124.0, 124.0, 118.0, 118.0, 156.0, 118.0], "value": 130.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 159.0, 160.0, 159.0, 159.0, 159.0, 160.0, 161.0, 159.0], "value": 159.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 107.0, 77.0, 76.0, 77.0, 76.0, 98.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 117.0, 81.0, 82.0, 82.0, 100.0, 82.0, 81.0, 118.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 50.0, 52.0, 51.0, 50.0, 53.0, 51.0, 52.0, 50.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 60.0, 60.0, 61.0, 59.0, 59.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 73.0, 74.0, 74.0, 74.0, 75.0, 75.0, 82.0, 74.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 126.0, 123.0, 122.0, 121.0, 121.0, 119.0, 123.0, 174.0, 122.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 154.0, 155.0, 155.0, 159.0, 156.0, 155.0, 157.0, 159.0, 158.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 67.0, 64.0, 66.0, 63.0, 62.0, 63.0, 66.0, 63.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1451.8000000000002, "alertThreshold": 2.0}]} 12:34:18 INFO - Return code: 0 12:34:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:34:18 INFO - # TBPL SUCCESS # 12:34:18 INFO - Running post-action listener: _resource_record_post_action 12:34:18 INFO - [mozharness: 2017-02-13 20:34:18.723719Z] Finished run-tests step (success) 12:34:18 INFO - Running post-run listener: _resource_record_post_run 12:34:18 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 325922816; Read time: 0; Write time: 183248 12:34:18 INFO - TinderboxPrint: CPU usage
13.0% 12:34:18 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:34:18 INFO - TinderboxPrint: I/O write bytes / time
325,922,816 / 183,248 12:34:18 INFO - TinderboxPrint: CPU idle
8,254.3 (87.0%) 12:34:18 INFO - TinderboxPrint: CPU user
1,187.0 (12.5%) 12:34:18 INFO - TinderboxPrint: Swap in / out
0 / 0 12:34:18 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 106815488; Read time: 0; Write time: 80032 12:34:18 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 219107328; Read time: 0; Write time: 103216 12:34:19 INFO - Running post-run listener: _upload_blobber_files 12:34:19 INFO - Blob upload gear active. 12:34:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:34:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:34:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:34:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:34:19 INFO - (blobuploader) - INFO - Open directory for files ... 12:34:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:34:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:34:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:34:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:34:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:34:20 INFO - (blobuploader) - INFO - Done attempting. 12:34:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:34:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:34:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:34:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:34:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:34:26 INFO - (blobuploader) - INFO - Done attempting. 12:34:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:34:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:34:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:34:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:34:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:34:30 INFO - (blobuploader) - INFO - Done attempting. 12:34:30 INFO - (blobuploader) - INFO - Iteration through files over. 12:34:30 INFO - Return code: 0 12:34:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:34:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:34:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d60ef5d9b0295943eb4e2f835d9b32d7032e491ad6cc70ab8de4830dd19ca5601fd8b0b2ec80d683b572e42ee44337444a0ad076e818a6ac836fefa6484096a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/77993d1a0f18031e5b7698b4487785d18ddaeea55a289ab154dbc65e0f024639b57c2c240fc23ec7ae09ae5591b0cdcae4735e224e0b2ae9f14939c27b3150ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee7509381516502dc98c2e5bc69fb5417bc8ad9cd179d60de93d3496215071c29aa14229a317dfe977035bb41003213e897c5d6288a6738a93110061f42d52ca"} 12:34:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:34:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:34:30 INFO - Contents: 12:34:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d60ef5d9b0295943eb4e2f835d9b32d7032e491ad6cc70ab8de4830dd19ca5601fd8b0b2ec80d683b572e42ee44337444a0ad076e818a6ac836fefa6484096a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/77993d1a0f18031e5b7698b4487785d18ddaeea55a289ab154dbc65e0f024639b57c2c240fc23ec7ae09ae5591b0cdcae4735e224e0b2ae9f14939c27b3150ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee7509381516502dc98c2e5bc69fb5417bc8ad9cd179d60de93d3496215071c29aa14229a317dfe977035bb41003213e897c5d6288a6738a93110061f42d52ca"} 12:34:30 INFO - Running post-run listener: copy_logs_to_upload_dir 12:34:30 INFO - Copying logs to upload dir... 12:34:30 INFO - mkdir: /builds/slave/test/build/upload/logs 12:34:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.619076 ========= master_lag: -0.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-02-13 12:34:29.366388) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 12:34:29.369691) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d60ef5d9b0295943eb4e2f835d9b32d7032e491ad6cc70ab8de4830dd19ca5601fd8b0b2ec80d683b572e42ee44337444a0ad076e818a6ac836fefa6484096a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/77993d1a0f18031e5b7698b4487785d18ddaeea55a289ab154dbc65e0f024639b57c2c240fc23ec7ae09ae5591b0cdcae4735e224e0b2ae9f14939c27b3150ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee7509381516502dc98c2e5bc69fb5417bc8ad9cd179d60de93d3496215071c29aa14229a317dfe977035bb41003213e897c5d6288a6738a93110061f42d52ca"} build_url:https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/cXCbbTiRRNyLnm1R6BYLMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d60ef5d9b0295943eb4e2f835d9b32d7032e491ad6cc70ab8de4830dd19ca5601fd8b0b2ec80d683b572e42ee44337444a0ad076e818a6ac836fefa6484096a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/77993d1a0f18031e5b7698b4487785d18ddaeea55a289ab154dbc65e0f024639b57c2c240fc23ec7ae09ae5591b0cdcae4735e224e0b2ae9f14939c27b3150ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee7509381516502dc98c2e5bc69fb5417bc8ad9cd179d60de93d3496215071c29aa14229a317dfe977035bb41003213e897c5d6288a6738a93110061f42d52ca"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 12:34:29.394542) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 12:34:29.394873) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1487016830.180903-387434706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 12:34:29.480619) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 12:34:29.481155) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 12:34:29.481727) ========= ========= Total master_lag: -0.22 =========