builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1487085839.74 results: success (0) buildid: 20170214055045 builduid: c5111bc88c204187a6bf9597e5806b05 revision: 1e3e791a5d2e7666024776e0e41e963e011dab55 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 07:23:59.743882) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 07:23:59.744306) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 07:23:59.744611) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 07:23:59.764100) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 07:23:59.764667) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-14 07:23:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2017-02-14 07:24:00 (217 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123416 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 07:23:59.901163) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 07:23:59.901472) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017889 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 07:23:59.950907) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-14 07:23:59.951239) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1e3e791a5d2e7666024776e0e41e963e011dab55 --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 1e3e791a5d2e7666024776e0e41e963e011dab55 --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=5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-14 07:24:00,182 truncating revision to first 12 chars 2017-02-14 07:24:00,182 Setting DEBUG logging. 2017-02-14 07:24:00,182 attempt 1/10 2017-02-14 07:24:00,182 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1e3e791a5d2e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-14 07:24:01,348 unpacking tar archive at: mozilla-beta-1e3e791a5d2e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.472053 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-14 07:24:01.436290) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 07:24:01.436614) ========= script_repo_revision: 1e3e791a5d2e7666024776e0e41e963e011dab55 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 07:24:01.437062) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 07:24:01.437334) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 07:24:01.446529) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-14 07:24:01.446848) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:24:01 INFO - MultiFileLogger online at 20170214 07:24:01 in /builds/slave/test 07:24:01 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 07:24:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:24:01 INFO - {'append_to_log': False, 07:24:01 INFO - 'base_work_dir': '/builds/slave/test', 07:24:01 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:24:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:24:01 INFO - 'branch': 'Mozilla-Beta', 07:24:01 INFO - 'buildbot_json_path': 'buildprops.json', 07:24:01 INFO - 'config_files': ('talos/linux_config.py',), 07:24:01 INFO - 'default_actions': ('clobber', 07:24:01 INFO - 'read-buildbot-config', 07:24:01 INFO - 'download-and-extract', 07:24:01 INFO - 'populate-webroot', 07:24:01 INFO - 'create-virtualenv', 07:24:01 INFO - 'install', 07:24:01 INFO - 'run-tests'), 07:24:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:24:01 INFO - 'download_minidump_stackwalk': True, 07:24:01 INFO - 'download_symbols': 'ondemand', 07:24:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:24:01 INFO - 'tooltool.py': '/tools/tooltool.py', 07:24:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:24:01 INFO - '/tools/misc-python/virtualenv.py')}, 07:24:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:24:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:24:01 INFO - 'installer_path': 'installer.exe', 07:24:01 INFO - 'log_level': 'info', 07:24:01 INFO - 'log_name': 'talos', 07:24:01 INFO - 'log_to_console': True, 07:24:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:24:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:24:01 INFO - 'opt_config_files': (), 07:24:01 INFO - 'pip_index': False, 07:24:01 INFO - 'sps_profile': False, 07:24:01 INFO - 'sps_profile_interval': 0, 07:24:01 INFO - 'suite': 'dromaeojs', 07:24:01 INFO - 'system_bits': '32', 07:24:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:24:01 INFO - 'title': 'talos-linux64-ix-051', 07:24:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:24:01 INFO - 'use_talos_json': True, 07:24:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:24:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:24:01 INFO - 'work_dir': 'build'} 07:24:01 INFO - [mozharness: 2017-02-14 15:24:01.780559Z] Running clobber step. 07:24:01 INFO - Running pre-action listener: _resource_record_pre_action 07:24:01 INFO - Running main action method: clobber 07:24:01 INFO - rmtree: /builds/slave/test/build 07:24:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:24:02 INFO - Running post-action listener: _resource_record_post_action 07:24:02 INFO - [mozharness: 2017-02-14 15:24:02.696573Z] Finished clobber step (success) 07:24:02 INFO - [mozharness: 2017-02-14 15:24:02.696674Z] Running read-buildbot-config step. 07:24:02 INFO - Running pre-action listener: _resource_record_pre_action 07:24:02 INFO - Running main action method: read_buildbot_config 07:24:02 INFO - Using buildbot properties: 07:24:02 INFO - { 07:24:02 INFO - "project": "", 07:24:02 INFO - "product": "firefox", 07:24:02 INFO - "script_repo_revision": "production", 07:24:02 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 07:24:02 INFO - "repository": "", 07:24:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 07:24:02 INFO - "buildid": "20170214055045", 07:24:02 INFO - "pgo_build": "True", 07:24:02 INFO - "basedir": "/builds/slave/test", 07:24:02 INFO - "buildnumber": 16, 07:24:02 INFO - "slavename": "talos-linux64-ix-051", 07:24:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:24:02 INFO - "platform": "ubuntu64_hw", 07:24:02 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 07:24:02 INFO - "branch": "mozilla-beta", 07:24:02 INFO - "repo_path": "releases/mozilla-beta", 07:24:02 INFO - "revision": "1e3e791a5d2e7666024776e0e41e963e011dab55", 07:24:02 INFO - "stage_platform": "linux64-pgo", 07:24:02 INFO - "builduid": "c5111bc88c204187a6bf9597e5806b05", 07:24:02 INFO - "slavebuilddir": "test" 07:24:02 INFO - } 07:24:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/CSWSCYxgR0WnOY1rvGYegQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 07:24:02 INFO - Running post-action listener: _resource_record_post_action 07:24:02 INFO - [mozharness: 2017-02-14 15:24:02.699149Z] Finished read-buildbot-config step (success) 07:24:02 INFO - [mozharness: 2017-02-14 15:24:02.699237Z] Running download-and-extract step. 07:24:02 INFO - Running pre-action listener: _resource_record_pre_action 07:24:02 INFO - Running main action method: download_and_extract 07:24:02 INFO - mkdir: /builds/slave/test/build/tests 07:24:02 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')]} 07:24:02 INFO - trying https://queue.taskcluster.net/v1/task/CSWSCYxgR0WnOY1rvGYegQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 07:24:02 INFO - Downloading https://queue.taskcluster.net/v1/task/CSWSCYxgR0WnOY1rvGYegQ/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 07:24:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CSWSCYxgR0WnOY1rvGYegQ/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 07:24:03 INFO - Downloaded 1327 bytes. 07:24:03 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 07:24:03 INFO - Using the following test package requirements: 07:24:03 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 07:24:03 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 07:24:03 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 07:24:03 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 07:24:03 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 07:24:03 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 07:24:03 INFO - u'jsshell-linux-x86_64.zip'], 07:24:03 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 07:24:03 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 07:24:03 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 07:24:03 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 07:24:03 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 07:24:03 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 07:24:03 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 07:24:03 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 07:24:03 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 07:24:03 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 07:24:03 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 07:24:03 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:24:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CSWSCYxgR0WnOY1rvGYegQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 07:24:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CSWSCYxgR0WnOY1rvGYegQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:24:03 INFO - Fetch https://queue.taskcluster.net/v1/task/CSWSCYxgR0WnOY1rvGYegQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 07:24:03 INFO - Http code: 200 07:24:03 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 07:24:03 INFO - x-amz-cf-id: ZYk320qHnFZRohjJMeMdgfEPa6Zp4dPuZlq45JFzoMuGOaV-EFGyRw== 07:24:03 INFO - x-amz-version-id: WnO1PgZDord1Il3g7I5N6Pefqy4MdiHl 07:24:04 INFO - Expected file size: 21959109 07:24:04 INFO - Obtained file size: 21959109 07:24:08 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 07:24:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CSWSCYxgR0WnOY1rvGYegQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 07:24:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CSWSCYxgR0WnOY1rvGYegQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:24:08 INFO - Fetch https://queue.taskcluster.net/v1/task/CSWSCYxgR0WnOY1rvGYegQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 07:24:08 INFO - Http code: 200 07:24:08 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 07:24:08 INFO - x-amz-cf-id: H_8z4ETWbRgwX_ZRXDqDEnVUmTQUOJdZeWKuwex9U-XjSgYhZrdYSA== 07:24:08 INFO - x-amz-version-id: WnO1PgZDord1Il3g7I5N6Pefqy4MdiHl 07:24:08 INFO - Expected file size: 21959109 07:24:08 INFO - Obtained file size: 21959109 07:24:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CSWSCYxgR0WnOY1rvGYegQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 07:24:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CSWSCYxgR0WnOY1rvGYegQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:24:13 INFO - Fetch https://queue.taskcluster.net/v1/task/CSWSCYxgR0WnOY1rvGYegQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 07:24:14 INFO - Http code: 200 07:24:14 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 07:24:14 INFO - x-amz-cf-id: dcnaMkgpSycAvbIsHhGkQf92WazI4jdhVCSYo147x5RKlrPe1YPBtQ== 07:24:14 INFO - x-amz-version-id: gFZNMFt._kcSS1_9khdSOuBTIZfWpQN. 07:24:14 INFO - Expected file size: 14403005 07:24:14 INFO - Obtained file size: 14403005 07:24:14 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')]} 07:24:14 INFO - trying https://queue.taskcluster.net/v1/task/CSWSCYxgR0WnOY1rvGYegQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 07:24:14 INFO - Downloading https://queue.taskcluster.net/v1/task/CSWSCYxgR0WnOY1rvGYegQ/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 07:24:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CSWSCYxgR0WnOY1rvGYegQ/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 07:24:15 INFO - Downloaded 57756170 bytes. 07:24:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CSWSCYxgR0WnOY1rvGYegQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 07:24:15 INFO - mkdir: /builds/slave/test/properties 07:24:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:24:15 INFO - Writing to file /builds/slave/test/properties/build_url 07:24:15 INFO - Contents: 07:24:15 INFO - build_url:https://queue.taskcluster.net/v1/task/CSWSCYxgR0WnOY1rvGYegQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 07:24:16 INFO - Running post-action listener: _resource_record_post_action 07:24:16 INFO - Running post-action listener: set_extra_try_arguments 07:24:16 INFO - [mozharness: 2017-02-14 15:24:16.546098Z] Finished download-and-extract step (success) 07:24:16 INFO - [mozharness: 2017-02-14 15:24:16.546325Z] Running populate-webroot step. 07:24:16 INFO - Running pre-action listener: _resource_record_pre_action 07:24:16 INFO - Running main action method: populate_webroot 07:24:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:24:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:24:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:24:16 INFO - '--tppagecycles', 07:24:16 INFO - '7'], 07:24:16 INFO - 'tests': ['tsvgm']}}, 07:24:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:24:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:24:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:24:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:24:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:24:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:24:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:16 INFO - 'talos_options': ['--disable-e10s'], 07:24:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:24:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:24:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:16 INFO - 'talos_options': ['--disable-e10s'], 07:24:16 INFO - 'tests': ['damp', 'tps']}, 07:24:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:16 INFO - 'tests': ['damp', 'tps']}, 07:24:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:24:16 INFO - 'tests': ['dromaeo_dom']}, 07:24:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:24:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:24:16 INFO - 'tests': ['basic_compositor_video']}, 07:24:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:24:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:24:16 INFO - 'tests': ['a11yr', 07:24:16 INFO - 'ts_paint', 07:24:16 INFO - 'tpaint', 07:24:16 INFO - 'sessionrestore', 07:24:16 INFO - 'sessionrestore_no_auto_restore', 07:24:16 INFO - 'tabpaint']}, 07:24:16 INFO - 'other-e10s': {'tests': ['a11yr', 07:24:16 INFO - 'ts_paint', 07:24:16 INFO - 'tpaint', 07:24:16 INFO - 'sessionrestore', 07:24:16 INFO - 'sessionrestore_no_auto_restore', 07:24:16 INFO - 'tabpaint']}, 07:24:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:24:16 INFO - 'ts_paint', 07:24:16 INFO - 'tpaint', 07:24:16 INFO - 'sessionrestore', 07:24:16 INFO - 'sessionrestore_no_auto_restore', 07:24:16 INFO - 'tabpaint']}, 07:24:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:24:16 INFO - 'ts_paint', 07:24:16 INFO - 'tpaint', 07:24:16 INFO - 'sessionrestore', 07:24:16 INFO - 'sessionrestore_no_auto_restore', 07:24:16 INFO - 'tabpaint']}, 07:24:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:24:16 INFO - 'tests': ['a11yr', 07:24:16 INFO - 'ts_paint', 07:24:16 INFO - 'tpaint', 07:24:16 INFO - 'sessionrestore', 07:24:16 INFO - 'sessionrestore_no_auto_restore', 07:24:16 INFO - 'tabpaint']}, 07:24:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:24:16 INFO - 'tests': ['a11yr', 07:24:16 INFO - 'ts_paint', 07:24:16 INFO - 'tpaint', 07:24:16 INFO - 'sessionrestore', 07:24:16 INFO - 'sessionrestore_no_auto_restore', 07:24:16 INFO - 'tabpaint']}, 07:24:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:24:16 INFO - 'tests': ['tsvgx', 07:24:16 INFO - 'tsvgr_opacity', 07:24:16 INFO - 'tart', 07:24:16 INFO - 'tscrollx', 07:24:16 INFO - 'cart']}, 07:24:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:24:16 INFO - 'tsvgr_opacity', 07:24:16 INFO - 'tart', 07:24:16 INFO - 'tscrollx', 07:24:16 INFO - 'cart']}, 07:24:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:16 INFO - 'talos_options': ['--disable-e10s'], 07:24:16 INFO - 'tests': ['tp5o']}, 07:24:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:16 INFO - 'tests': ['tp5o']}, 07:24:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:16 INFO - 'talos_options': ['--disable-e10s', 07:24:16 INFO - '--xperf_path', 07:24:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:24:16 INFO - 'tests': ['tp5n']}, 07:24:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:16 INFO - 'talos_options': ['--xperf_path', 07:24:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:24:16 INFO - 'tests': ['tp5n']}}, 07:24:16 INFO - 'talos.zip': {'path': '', 07:24:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:24:16 INFO - Running post-action listener: _resource_record_post_action 07:24:16 INFO - [mozharness: 2017-02-14 15:24:16.561817Z] Finished populate-webroot step (success) 07:24:16 INFO - [mozharness: 2017-02-14 15:24:16.561905Z] Running create-virtualenv step. 07:24:16 INFO - Running pre-action listener: _resource_record_pre_action 07:24:16 INFO - Running main action method: create_virtualenv 07:24:16 INFO - Creating virtualenv /builds/slave/test/build/venv 07:24:16 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 07:24:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:24:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:24:16 INFO - Using real prefix '/usr' 07:24:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:24:17 INFO - Installing distribute.............................................................................................................................................................................................done. 07:24:19 INFO - Installing pip.................done. 07:24:19 INFO - Return code: 0 07:24:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:24:19 INFO - Reading from file tmpfile_stdout 07:24:19 INFO - Output received: 07:24:19 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) 07:24:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:24:19 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')]} 07:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:19 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')]} 07:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:19 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 0x7fc911f85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc4f60>, '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 0x1bc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc61d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178', '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 07:24:19 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 07:24:19 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 07:24:19 INFO - Using env: {'DISPLAY': ':0', 07:24:19 INFO - 'HOME': '/home/cltbld', 07:24:19 INFO - 'LANG': 'en_US.UTF-8', 07:24:19 INFO - 'LANGUAGE': 'en_US:en', 07:24:19 INFO - 'LOGNAME': 'cltbld', 07:24:19 INFO - 'MAIL': '/var/mail/cltbld', 07:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:19 INFO - 'MOZ_NO_REMOTE': '1', 07:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:19 INFO - 'NO_EM_RESTART': '1', 07:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:19 INFO - 'PWD': '/builds/slave/test', 07:24:19 INFO - 'SHELL': '/bin/bash', 07:24:19 INFO - 'SHLVL': '1', 07:24:19 INFO - 'TERM': 'linux', 07:24:19 INFO - 'TMOUT': '86400', 07:24:19 INFO - 'USER': 'cltbld', 07:24:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178', 07:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:19 INFO - '_': '/tools/buildbot/bin/python'} 07:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:19 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 07:24:19 INFO - Cleaning up... 07:24:19 INFO - Return code: 0 07:24:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:24:19 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')]} 07:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:19 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')]} 07:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:19 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 0x7fc911f85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc4f60>, '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 0x1bc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc61d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178', '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 07:24:19 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 07:24:19 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 07:24:19 INFO - Using env: {'DISPLAY': ':0', 07:24:19 INFO - 'HOME': '/home/cltbld', 07:24:19 INFO - 'LANG': 'en_US.UTF-8', 07:24:19 INFO - 'LANGUAGE': 'en_US:en', 07:24:19 INFO - 'LOGNAME': 'cltbld', 07:24:19 INFO - 'MAIL': '/var/mail/cltbld', 07:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:19 INFO - 'MOZ_NO_REMOTE': '1', 07:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:19 INFO - 'NO_EM_RESTART': '1', 07:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:19 INFO - 'PWD': '/builds/slave/test', 07:24:19 INFO - 'SHELL': '/bin/bash', 07:24:19 INFO - 'SHLVL': '1', 07:24:19 INFO - 'TERM': 'linux', 07:24:19 INFO - 'TMOUT': '86400', 07:24:19 INFO - 'USER': 'cltbld', 07:24:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178', 07:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:19 INFO - '_': '/tools/buildbot/bin/python'} 07:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:19 INFO - Downloading/unpacking psutil>=3.1.1 07:24:19 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 07:24:19 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 07:24:19 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 07:24:19 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 07:24:19 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 07:24:19 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 07:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:24:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:24:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:24:21 INFO - Installing collected packages: psutil 07:24:21 INFO - Running setup.py install for psutil 07:24:21 INFO - building 'psutil._psutil_linux' extension 07:24:21 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 07:24:22 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 07:24:22 INFO - building 'psutil._psutil_posix' extension 07:24:22 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 07:24:22 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 07:24:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:24:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:24:22 INFO - Successfully installed psutil 07:24:22 INFO - Cleaning up... 07:24:22 INFO - Return code: 0 07:24:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:24: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')]} 07:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24: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')]} 07:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:22 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 0x7fc911f85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc4f60>, '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 0x1bc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc61d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178', '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 07:24:22 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 07:24:22 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 07:24:22 INFO - Using env: {'DISPLAY': ':0', 07:24:22 INFO - 'HOME': '/home/cltbld', 07:24:22 INFO - 'LANG': 'en_US.UTF-8', 07:24:22 INFO - 'LANGUAGE': 'en_US:en', 07:24:22 INFO - 'LOGNAME': 'cltbld', 07:24:22 INFO - 'MAIL': '/var/mail/cltbld', 07:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:22 INFO - 'MOZ_NO_REMOTE': '1', 07:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:22 INFO - 'NO_EM_RESTART': '1', 07:24:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:22 INFO - 'PWD': '/builds/slave/test', 07:24:22 INFO - 'SHELL': '/bin/bash', 07:24:22 INFO - 'SHLVL': '1', 07:24:22 INFO - 'TERM': 'linux', 07:24:22 INFO - 'TMOUT': '86400', 07:24:22 INFO - 'USER': 'cltbld', 07:24:22 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178', 07:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:22 INFO - '_': '/tools/buildbot/bin/python'} 07:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:24:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:24:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:24:24 INFO - Installing collected packages: mozsystemmonitor 07:24:24 INFO - Running setup.py install for mozsystemmonitor 07:24:24 INFO - Successfully installed mozsystemmonitor 07:24:24 INFO - Cleaning up... 07:24:24 INFO - Return code: 0 07:24:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:24:24 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')]} 07:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:24 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')]} 07:24:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:24 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 0x7fc911f85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc4f60>, '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 0x1bc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc61d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178', '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 07:24:24 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 07:24:24 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 07:24:24 INFO - Using env: {'DISPLAY': ':0', 07:24:24 INFO - 'HOME': '/home/cltbld', 07:24:24 INFO - 'LANG': 'en_US.UTF-8', 07:24:24 INFO - 'LANGUAGE': 'en_US:en', 07:24:24 INFO - 'LOGNAME': 'cltbld', 07:24:24 INFO - 'MAIL': '/var/mail/cltbld', 07:24:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:24 INFO - 'MOZ_NO_REMOTE': '1', 07:24:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:24 INFO - 'NO_EM_RESTART': '1', 07:24:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:24 INFO - 'PWD': '/builds/slave/test', 07:24:24 INFO - 'SHELL': '/bin/bash', 07:24:24 INFO - 'SHLVL': '1', 07:24:24 INFO - 'TERM': 'linux', 07:24:24 INFO - 'TMOUT': '86400', 07:24:24 INFO - 'USER': 'cltbld', 07:24:24 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178', 07:24:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:24 INFO - '_': '/tools/buildbot/bin/python'} 07:24:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:25 INFO - Downloading/unpacking jsonschema==2.5.1 07:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:24:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:24:27 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 07:24:27 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 07:24:27 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 07:24:27 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 07:24:27 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 07:24:27 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 07:24:27 INFO - Downloading functools32-3.2.3-2.tar.gz 07:24:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:24:27 INFO - warning: no files found matching '*.txt' 07:24:27 INFO - no previously-included directories found matching 'build' 07:24:27 INFO - no previously-included directories found matching 'dist' 07:24:27 INFO - no previously-included directories found matching '.git*' 07:24:27 INFO - Installing collected packages: jsonschema, functools32 07:24:27 INFO - Running setup.py install for functools32 07:24:27 INFO - warning: no files found matching '*.txt' 07:24:27 INFO - no previously-included directories found matching 'build' 07:24:27 INFO - no previously-included directories found matching 'dist' 07:24:27 INFO - no previously-included directories found matching '.git*' 07:24:27 INFO - Successfully installed jsonschema functools32 07:24:27 INFO - Cleaning up... 07:24:27 INFO - Return code: 0 07:24:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:27 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 0x7fc911f85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc4f60>, '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 0x1bc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc61d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178', '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 07:24:27 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 07:24:27 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 07:24:27 INFO - Using env: {'DISPLAY': ':0', 07:24:27 INFO - 'HOME': '/home/cltbld', 07:24:27 INFO - 'LANG': 'en_US.UTF-8', 07:24:27 INFO - 'LANGUAGE': 'en_US:en', 07:24:27 INFO - 'LOGNAME': 'cltbld', 07:24:27 INFO - 'MAIL': '/var/mail/cltbld', 07:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:27 INFO - 'MOZ_NO_REMOTE': '1', 07:24:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:27 INFO - 'NO_EM_RESTART': '1', 07:24:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:27 INFO - 'PWD': '/builds/slave/test', 07:24:27 INFO - 'SHELL': '/bin/bash', 07:24:27 INFO - 'SHLVL': '1', 07:24:27 INFO - 'TERM': 'linux', 07:24:27 INFO - 'TMOUT': '86400', 07:24:27 INFO - 'USER': 'cltbld', 07:24:27 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178', 07:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:27 INFO - '_': '/tools/buildbot/bin/python'} 07:24:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:24:27 INFO - Cleaning up... 07:24:27 INFO - Return code: 0 07:24:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:27 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 0x7fc911f85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc4f60>, '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 0x1bc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc61d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178', '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 07:24:27 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 07:24:27 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 07:24:27 INFO - Using env: {'DISPLAY': ':0', 07:24:27 INFO - 'HOME': '/home/cltbld', 07:24:27 INFO - 'LANG': 'en_US.UTF-8', 07:24:27 INFO - 'LANGUAGE': 'en_US:en', 07:24:27 INFO - 'LOGNAME': 'cltbld', 07:24:27 INFO - 'MAIL': '/var/mail/cltbld', 07:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:27 INFO - 'MOZ_NO_REMOTE': '1', 07:24:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:27 INFO - 'NO_EM_RESTART': '1', 07:24:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:27 INFO - 'PWD': '/builds/slave/test', 07:24:27 INFO - 'SHELL': '/bin/bash', 07:24:27 INFO - 'SHLVL': '1', 07:24:27 INFO - 'TERM': 'linux', 07:24:27 INFO - 'TMOUT': '86400', 07:24:27 INFO - 'USER': 'cltbld', 07:24:27 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178', 07:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:27 INFO - '_': '/tools/buildbot/bin/python'} 07:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:28 INFO - Downloading/unpacking blobuploader==1.2.4 07:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:30 INFO - Downloading blobuploader-1.2.4.tar.gz 07:24:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:24:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:24:30 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 07:24:30 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 07:24:30 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 07:24:30 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 07:24:30 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 07:24:30 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 07:24:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:24:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:24:30 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 07:24:30 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 07:24:30 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 07:24:30 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 07:24:30 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 07:24:30 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 07:24:30 INFO - Downloading docopt-0.6.1.tar.gz 07:24:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:24:30 INFO - Installing collected packages: blobuploader, requests, docopt 07:24:30 INFO - Running setup.py install for blobuploader 07:24:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:24:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:24:30 INFO - Running setup.py install for requests 07:24:31 INFO - Running setup.py install for docopt 07:24:31 INFO - Successfully installed blobuploader requests docopt 07:24:31 INFO - Cleaning up... 07:24:31 INFO - Return code: 0 07:24:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:24:31 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')]} 07:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:31 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')]} 07:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:31 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 0x7fc911f85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc4f60>, '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 0x1bc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc61d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178', '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 07:24:31 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 07:24:31 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 07:24:31 INFO - Using env: {'DISPLAY': ':0', 07:24:31 INFO - 'HOME': '/home/cltbld', 07:24:31 INFO - 'LANG': 'en_US.UTF-8', 07:24:31 INFO - 'LANGUAGE': 'en_US:en', 07:24:31 INFO - 'LOGNAME': 'cltbld', 07:24:31 INFO - 'MAIL': '/var/mail/cltbld', 07:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:31 INFO - 'MOZ_NO_REMOTE': '1', 07:24:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:31 INFO - 'NO_EM_RESTART': '1', 07:24:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:31 INFO - 'PWD': '/builds/slave/test', 07:24:31 INFO - 'SHELL': '/bin/bash', 07:24:31 INFO - 'SHLVL': '1', 07:24:31 INFO - 'TERM': 'linux', 07:24:31 INFO - 'TMOUT': '86400', 07:24:31 INFO - 'USER': 'cltbld', 07:24:31 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178', 07:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:31 INFO - '_': '/tools/buildbot/bin/python'} 07:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:24:31 INFO - Running setup.py (path:/tmp/pip-NduIDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:24:31 INFO - Running setup.py (path:/tmp/pip-bw2lGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:24:31 INFO - Running setup.py (path:/tmp/pip-nq6mgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:24:31 INFO - Running setup.py (path:/tmp/pip-Th3dnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:24:31 INFO - Running setup.py (path:/tmp/pip-wgsfhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:24:32 INFO - Running setup.py (path:/tmp/pip-6qGf83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:24:32 INFO - Running setup.py (path:/tmp/pip-a8F1Dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:24:32 INFO - Running setup.py (path:/tmp/pip-1Df4XH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:24:32 INFO - Running setup.py (path:/tmp/pip-HxHjpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:24:32 INFO - Running setup.py (path:/tmp/pip-vzzEbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:24:32 INFO - Running setup.py (path:/tmp/pip-qzVgxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:24:32 INFO - Running setup.py (path:/tmp/pip-UIGPvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:24:32 INFO - Running setup.py (path:/tmp/pip-sEkurj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:24:32 INFO - Running setup.py (path:/tmp/pip-b6rnRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:24:32 INFO - Running setup.py (path:/tmp/pip-pnm86w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:24:32 INFO - Running setup.py (path:/tmp/pip-QTI838-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:24:32 INFO - Running setup.py (path:/tmp/pip-Ss149B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:24:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:24:32 INFO - Running setup.py install for manifestparser 07:24:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:24:32 INFO - Running setup.py install for mozcrash 07:24:33 INFO - Running setup.py install for mozdebug 07:24:33 INFO - Running setup.py install for mozdevice 07:24:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:24:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:24:33 INFO - Running setup.py install for mozfile 07:24:33 INFO - Running setup.py install for mozhttpd 07:24:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:24:33 INFO - Running setup.py install for mozinfo 07:24:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:24:33 INFO - Running setup.py install for mozInstall 07:24:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:24:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:24:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:24:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:24:33 INFO - Running setup.py install for mozleak 07:24:33 INFO - Running setup.py install for mozlog 07:24:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:24:33 INFO - Running setup.py install for moznetwork 07:24:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:24:34 INFO - Running setup.py install for mozprocess 07:24:34 INFO - Running setup.py install for mozprofile 07:24:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:24:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:24:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:24:34 INFO - Running setup.py install for mozrunner 07:24:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:24:34 INFO - Running setup.py install for mozscreenshot 07:24:34 INFO - Running setup.py install for moztest 07:24:34 INFO - Running setup.py install for mozversion 07:24:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:24:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:24:34 INFO - Cleaning up... 07:24:34 INFO - Return code: 0 07:24:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:34 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 0x7fc911f85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc4f60>, '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 0x1bc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc61d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178', '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 07:24:34 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 07:24:34 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 07:24:34 INFO - Using env: {'DISPLAY': ':0', 07:24:34 INFO - 'HOME': '/home/cltbld', 07:24:34 INFO - 'LANG': 'en_US.UTF-8', 07:24:34 INFO - 'LANGUAGE': 'en_US:en', 07:24:34 INFO - 'LOGNAME': 'cltbld', 07:24:34 INFO - 'MAIL': '/var/mail/cltbld', 07:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:34 INFO - 'MOZ_NO_REMOTE': '1', 07:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:34 INFO - 'NO_EM_RESTART': '1', 07:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:34 INFO - 'PWD': '/builds/slave/test', 07:24:34 INFO - 'SHELL': '/bin/bash', 07:24:34 INFO - 'SHLVL': '1', 07:24:34 INFO - 'TERM': 'linux', 07:24:34 INFO - 'TMOUT': '86400', 07:24:34 INFO - 'USER': 'cltbld', 07:24:34 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178', 07:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:34 INFO - '_': '/tools/buildbot/bin/python'} 07:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:24:34 INFO - Running setup.py (path:/tmp/pip-0qnbdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:24:35 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)) 07:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:24:35 INFO - Running setup.py (path:/tmp/pip-UMFBt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:24:35 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)) 07:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:24:35 INFO - Running setup.py (path:/tmp/pip-LaVVUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:24:35 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)) 07:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:24:35 INFO - Running setup.py (path:/tmp/pip-9Owl1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:24:35 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)) 07:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:24:35 INFO - Running setup.py (path:/tmp/pip-mELw8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:24:35 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)) 07:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:24:35 INFO - Running setup.py (path:/tmp/pip-BdtxjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:24:35 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)) 07:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:24:35 INFO - Running setup.py (path:/tmp/pip-_qUsoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:24:35 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)) 07:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:24:35 INFO - Running setup.py (path:/tmp/pip-QTBjVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:24:35 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)) 07:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:24:35 INFO - Running setup.py (path:/tmp/pip-U_3DLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:24:35 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)) 07:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:24:35 INFO - Running setup.py (path:/tmp/pip-EL6zDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:24:35 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)) 07:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:24:35 INFO - Running setup.py (path:/tmp/pip-pn5nLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:24:35 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)) 07:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:24:35 INFO - Running setup.py (path:/tmp/pip-ktQjm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:24:35 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)) 07:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:24:35 INFO - Running setup.py (path:/tmp/pip-_7FMhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:24:35 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)) 07:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:24:35 INFO - Running setup.py (path:/tmp/pip-NkhyXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:24:35 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)) 07:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:24:35 INFO - Running setup.py (path:/tmp/pip-FHMocz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:24:36 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)) 07:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:24:36 INFO - Running setup.py (path:/tmp/pip-3TRxfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:24:36 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)) 07:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:24:36 INFO - Running setup.py (path:/tmp/pip-s8VwWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:24:36 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)) 07:24:36 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)) 07:24:36 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)) 07:24:36 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)) 07:24:36 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)) 07:24:36 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)) 07:24:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:38 INFO - Downloading blessings-1.6.tar.gz 07:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:24:38 INFO - Installing collected packages: blessings 07:24:38 INFO - Running setup.py install for blessings 07:24:38 INFO - Successfully installed blessings 07:24:38 INFO - Cleaning up... 07:24:38 INFO - Return code: 0 07:24:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:24:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:24:38 INFO - Reading from file tmpfile_stdout 07:24:38 INFO - Current package versions: 07:24:38 INFO - argparse == 1.2.1 07:24:38 INFO - blessings == 1.6 07:24:38 INFO - blobuploader == 1.2.4 07:24:38 INFO - docopt == 0.6.1 07:24:38 INFO - functools32 == 3.2.3-2 07:24:38 INFO - jsonschema == 2.5.1 07:24:38 INFO - manifestparser == 1.1 07:24:38 INFO - mozInstall == 1.12 07:24:38 INFO - mozcrash == 1.0 07:24:38 INFO - mozdebug == 0.1 07:24:38 INFO - mozdevice == 0.48 07:24:38 INFO - mozfile == 1.2 07:24:38 INFO - mozhttpd == 0.7 07:24:38 INFO - mozinfo == 0.9 07:24:38 INFO - mozleak == 0.1 07:24:38 INFO - mozlog == 3.4 07:24:38 INFO - moznetwork == 0.27 07:24:38 INFO - mozprocess == 0.23 07:24:38 INFO - mozprofile == 0.28 07:24:38 INFO - mozrunner == 6.13 07:24:38 INFO - mozscreenshot == 0.1 07:24:38 INFO - mozsystemmonitor == 0.3 07:24:38 INFO - moztest == 0.8 07:24:38 INFO - mozversion == 1.4 07:24:38 INFO - psutil == 3.1.1 07:24:38 INFO - requests == 1.2.3 07:24:38 INFO - wsgiref == 0.1.2 07:24:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:38 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 0x7fc911f85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc4f60>, '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 0x1bc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc61d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178', '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 07:24:38 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 07:24:38 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 07:24:38 INFO - Using env: {'DISPLAY': ':0', 07:24:38 INFO - 'HOME': '/home/cltbld', 07:24:38 INFO - 'LANG': 'en_US.UTF-8', 07:24:38 INFO - 'LANGUAGE': 'en_US:en', 07:24:38 INFO - 'LOGNAME': 'cltbld', 07:24:38 INFO - 'MAIL': '/var/mail/cltbld', 07:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:38 INFO - 'MOZ_NO_REMOTE': '1', 07:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:38 INFO - 'NO_EM_RESTART': '1', 07:24:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:38 INFO - 'PWD': '/builds/slave/test', 07:24:38 INFO - 'SHELL': '/bin/bash', 07:24:38 INFO - 'SHLVL': '1', 07:24:38 INFO - 'TERM': 'linux', 07:24:38 INFO - 'TMOUT': '86400', 07:24:38 INFO - 'USER': 'cltbld', 07:24:38 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178', 07:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:38 INFO - '_': '/tools/buildbot/bin/python'} 07:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:38 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)) 07:24:38 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)) 07:24:38 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)) 07:24:38 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)) 07:24:38 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)) 07:24:38 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)) 07:24:38 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)) 07:24:38 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)) 07:24:38 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)) 07:24:38 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)) 07:24:38 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)) 07:24:38 INFO - Cleaning up... 07:24:38 INFO - Return code: 0 07:24:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc911f85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc4f60>, '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 0x1bc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc61d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178', '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 07:24:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:24:38 INFO - Using env: {'DISPLAY': ':0', 07:24:38 INFO - 'HOME': '/home/cltbld', 07:24:38 INFO - 'LANG': 'en_US.UTF-8', 07:24:38 INFO - 'LANGUAGE': 'en_US:en', 07:24:38 INFO - 'LOGNAME': 'cltbld', 07:24:38 INFO - 'MAIL': '/var/mail/cltbld', 07:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:38 INFO - 'MOZ_NO_REMOTE': '1', 07:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:38 INFO - 'NO_EM_RESTART': '1', 07:24:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:38 INFO - 'PWD': '/builds/slave/test', 07:24:38 INFO - 'SHELL': '/bin/bash', 07:24:38 INFO - 'SHLVL': '1', 07:24:38 INFO - 'TERM': 'linux', 07:24:38 INFO - 'TMOUT': '86400', 07:24:38 INFO - 'USER': 'cltbld', 07:24:38 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178', 07:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:38 INFO - '_': '/tools/buildbot/bin/python'} 07:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:24:39 INFO - Cleaning up... 07:24:39 INFO - Return code: 0 07:24:39 INFO - Running post-action listener: _resource_record_post_action 07:24:39 INFO - Running post-action listener: _start_resource_monitoring 07:24:39 INFO - Starting resource monitoring. 07:24:39 INFO - [mozharness: 2017-02-14 15:24:39.163182Z] Finished create-virtualenv step (success) 07:24:39 INFO - [mozharness: 2017-02-14 15:24:39.163646Z] Running install step. 07:24:39 INFO - Running pre-action listener: _resource_record_pre_action 07:24:39 INFO - Running main action method: install 07:24:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:24:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:24:39 INFO - Reading from file tmpfile_stdout 07:24:39 INFO - Detecting whether we're running mozinstall >=1.0... 07:24:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:24:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:24:39 INFO - Reading from file tmpfile_stdout 07:24:39 INFO - Output received: 07:24:39 INFO - Usage: mozinstall [options] installer 07:24:39 INFO - Options: 07:24:39 INFO - -h, --help show this help message and exit 07:24:39 INFO - -d DEST, --destination=DEST 07:24:39 INFO - Directory to install application into. [default: 07:24:39 INFO - "/builds/slave/test"] 07:24:39 INFO - --app=APP Application being installed. [default: firefox] 07:24:39 INFO - mkdir: /builds/slave/test/build/application 07:24:39 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'] 07:24:39 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 07:24:53 INFO - Reading from file tmpfile_stdout 07:24:53 INFO - Output received: 07:24:53 INFO - /builds/slave/test/build/application/firefox/firefox 07:24:53 INFO - Running post-action listener: _resource_record_post_action 07:24:53 INFO - [mozharness: 2017-02-14 15:24:53.091301Z] Finished install step (success) 07:24:53 INFO - [mozharness: 2017-02-14 15:24:53.091545Z] Running run-tests step. 07:24:53 INFO - Running pre-action listener: _resource_record_pre_action 07:24:53 INFO - Running main action method: run_tests 07:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:24:53 INFO - Python 2.7.3 07:24:53 INFO - Return code: 0 07:24:53 INFO - grabbing minidump binary from tooltool 07:24: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')]} 07:24:53 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 0x1bc4f60>, '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 0x1bc5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc61d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:24:53 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 07:24:53 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 07:24:53 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 07:24:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:24:53 INFO - Return code: 0 07:24:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:24:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:24:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:24:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:24:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:24:53 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/CSWSCYxgR0WnOY1rvGYegQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 07:24:53 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/CSWSCYxgR0WnOY1rvGYegQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 07:24:53 INFO - Using env: {'DISPLAY': ':0', 07:24:53 INFO - 'HOME': '/home/cltbld', 07:24:53 INFO - 'LANG': 'en_US.UTF-8', 07:24:53 INFO - 'LANGUAGE': 'en_US:en', 07:24:53 INFO - 'LOGNAME': 'cltbld', 07:24:53 INFO - 'MAIL': '/var/mail/cltbld', 07:24:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:24:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:53 INFO - 'MOZ_NO_REMOTE': '1', 07:24:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:53 INFO - 'NO_EM_RESTART': '1', 07:24:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:53 INFO - 'PWD': '/builds/slave/test', 07:24:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:24:53 INFO - 'SHELL': '/bin/bash', 07:24:53 INFO - 'SHLVL': '1', 07:24:53 INFO - 'TERM': 'linux', 07:24:53 INFO - 'TMOUT': '86400', 07:24:53 INFO - 'USER': 'cltbld', 07:24:53 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178', 07:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:53 INFO - '_': '/tools/buildbot/bin/python'} 07:24:53 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/CSWSCYxgR0WnOY1rvGYegQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 07:24:53 INFO - mozversion application_buildid: 20170214055045 07:24:53 INFO - mozversion application_changeset: 1e3e791a5d2e7666024776e0e41e963e011dab55 07:24:53 INFO - mozversion application_display_name: Firefox 07:24:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:24:53 INFO - mozversion application_name: Firefox 07:24:53 INFO - mozversion application_remotingname: firefox 07:24:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:24:53 INFO - mozversion application_vendor: Mozilla 07:24:53 INFO - mozversion application_version: 52.0 07:24:53 INFO - mozversion platform_buildid: 20170214055045 07:24:53 INFO - mozversion platform_changeset: 1e3e791a5d2e7666024776e0e41e963e011dab55 07:24:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:24:53 INFO - mozversion platform_version: 52.0 07:24:53 INFO - using testdate: 1487085893 07:24:53 INFO - actual date: 1487085893 07:24:53 INFO - starting webserver on 'localhost:44396' 07:24:53 INFO - SUITE-START | Running 2 tests 07:24:53 INFO - TEST-START | dromaeo_css 07:24:53 INFO - operating with platform_type : linux_ 07:24:53 INFO - Initialising browser for dromaeo_css test... 07:24:53 INFO - TEST-INFO | started process 25296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuNy_vD/profile http://localhost:44396/getInfo.html) 07:24:57 INFO - PROCESS | 25296 | __metrics Screen width/height:1600/1200 07:24:57 INFO - PROCESS | 25296 | colorDepth:24 07:24:57 INFO - PROCESS | 25296 | Browser inner width/height: 1024/697 07:24:57 INFO - PROCESS | 25296 | __metrics 07:24:58 INFO - PROCESS | 25296 | 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" 07:24:58 INFO - PROCESS | 25296 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:24:58 INFO - PROCESS | 25296 | console.error: PushService: 07:24:58 INFO - PROCESS | 25296 | stateChangeProcessEnqueue: Error transitioning state 07:24:58 INFO - PROCESS | 25296 | UnknownError 07:24:59 INFO - TEST-INFO | 25296: exit 0 07:24:59 INFO - Browser initialized. 07:24:59 INFO - Running cycle 1/1 for dromaeo_css test... 07:24:59 INFO - TEST-INFO | started process 25389 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuNy_vD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:10 INFO - PROCESS | 25389 | RSS: Main: 141438976 07:25:10 INFO - PROCESS | 25389 | 07:28:12 INFO - PROCESS | 25389 | Cycle 1(1): loaded http://localhost:44396/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44396/tests/dromaeo/cssquery-ext.html) 07:28:13 INFO - PROCESS | 25389 | RSS: Main: 236236800 07:28:13 INFO - PROCESS | 25389 | 07:31:15 INFO - PROCESS | 25389 | Cycle 1(1): loaded http://localhost:44396/tests/dromaeo/cssquery-ext.html (next: http://localhost:44396/tests/dromaeo/cssquery-jquery.html) 07:31:16 INFO - PROCESS | 25389 | RSS: Main: 231915520 07:31:16 INFO - PROCESS | 25389 | 07:34:18 INFO - PROCESS | 25389 | Cycle 1(1): loaded http://localhost:44396/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44396/tests/dromaeo/cssquery-mootools.html) 07:34:18 INFO - PROCESS | 25389 | RSS: Main: 177246208 07:34:18 INFO - PROCESS | 25389 | 07:37:20 INFO - PROCESS | 25389 | Cycle 1(1): loaded http://localhost:44396/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44396/tests/dromaeo/cssquery-prototype.html) 07:37:21 INFO - PROCESS | 25389 | RSS: Main: 218873856 07:37:21 INFO - PROCESS | 25389 | 07:40:24 INFO - PROCESS | 25389 | Cycle 1(1): loaded http://localhost:44396/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44396/tests/dromaeo/cssquery-yui.html) 07:40:24 INFO - PROCESS | 25389 | RSS: Main: 176746496 07:40:24 INFO - PROCESS | 25389 | 07:43:26 INFO - PROCESS | 25389 | Cycle 1(1): loaded http://localhost:44396/tests/dromaeo/cssquery-yui.html (next: http://localhost:44396/tests/dromaeo/cssquery-dojo.html) 07:43:27 INFO - PROCESS | 25389 | RSS: Main: 263028736 07:43:27 INFO - PROCESS | 25389 | 07:43:27 INFO - PROCESS | 25389 | __start_tp_report 07:43:27 INFO - PROCESS | 25389 | _x_x_mozilla_page_load 07:43:27 INFO - PROCESS | 25389 | _x_x_mozilla_page_load_details 07:43:27 INFO - PROCESS | 25389 | |i|pagename|runs| 07:43:27 INFO - PROCESS | 25389 | |0;dojo.html;3205.615326160861;3223.6131664200298;3232.9191770205744;3247;3275.4431746603077;5541.307336582927;5602.131669591215;5617.325920889499;5617.4382561743905;5624.0439125348685;5667.178259152421;5720.084786434171;5733.397993210715;5733.770649174038;5765.942340576593;5147.408048074463;5183.974080129594;5202.687838729688;5230.293910322096;5256.211568264753;5063.696178229299;5106.259592359106;5109.897802043957;5262.05283049051;5289.391719952197;5136.717480538568;5196.532312091911;5201.86995325118;5226.947730522684;5239.895202095956;5198.0383629028565;5208.921866172011;5215.243789650517;5219.086659834514;5245.711485868275;4944.431390390079;5038.748062596856;5126.384833819965;5135.589152867761;5205.973970130163;5467.808626698086;5509.035918714209;5550.16747487876;5584.106542953108;5608.4111168327145;5964.642121472682;5984.670843103628;6013.6993150342305;6019.187409699722;6022.969885150546;5907.556933230025;6043.6675982820925;6048.939510604881;6052.273727152726;6069.635821850703;5543.584231182677;5611.3546942101775;5653.632513886584;5669.773209071591;5696.287964004499;6225.501959843202;6237.656928868865;6238.968805155945;6244;6246.562740608114;5829.679367634736;5998.700064996733;5999.850003749942;6005;6005.759769609254;5898.056310990307;6047.15339852421;6080.0575910733905;6106.2061931948565;6147.0779383092;6116.119654120117;6119.898632333103;6120.2610859299775;6120.975172448212;6124.971343706056;6063.272407311063;6106.145139680449;6106.297775755756;6107.8473038173515;6134.35589263121;4564.497905230422;4570.977145114253;4638.698484598558;4678.0410015946645;4727.030958653468;4175.707700460938;4178.039051018222;4192.11965487245;4198.307279298942;4213.705040647125;5831.912521312183;5832.679202643811;5836.328822185503;5839.416058394127;5846.210761547137;5916.142159386951;5919.1713160157615;5958.2850057992455;6117.510599152057;6143.815685529441;5694.174344719992;5704.4295570443455;5725.083986562214;5743.483086522149;5784.652920824764;5187.870303242449;5190.6366554341585;5206.219067139959;5217.895642087137;5218.452062533379;6086.330503644507;6214.751409943642;6261.436470717657;6273.059041143865;6280.717367718372;5876.706164691834;5934.465898069195;6036.396360363929;6052.66710330936;6078.179445774764;6245.843853903689;6298.685065746786;6311.842203944754;6351.650659213788;6357.554971151975;5983;5987.371326010706;5988.716333406424;5988.730507127103;5991.131285963424;5803.622764520462;5940.138679891478;6006.159137720635;6023.216981792339;6033.487153591994;5886.411358864079;5887.4406931341455;5895.41045895407;5896.469317761422;5900.881982360414;5885.852853678693;5890.2342695449315;5894.616849904743;5894.941050589439;5967;5712.828615141552;5821.505172060253;5823.8835223294445;5852.531797456279;5890.057590785454;5976.551758618034;5982.760689572542;5990.610610310316;6004.979153543995;6011.128386383863;5642.746076426489;5773.076307790733;5833.737481813244;5837.5329973601165;5842.328132264844 07:43:27 INFO - PROCESS | 25389 | |1;ext.html;580.4079838564664;631.8862604731148;644.761438267841;660.3693472733537;666.0542030316949;33519.66480335196;44873;45734.542654573444;45817.08365832681;45879.31181032283;46259.537404625946;46423.53576464234;46640.53359466404;46710.06579868409;46750.53249467504;8329.250367466926;8897.555122243893;9028.052054534244;9037.141471560191;9040.909590904073;8349.916500835005;10590.947045264802;10842.891571084267;10847.67456976288;11157.888421115766;10885.455727213648;10947;10967.670969870876;10969.506372213229;10978.396188209645;10836.783264334708;10889.891101088966;10893.891061089407;10907.181961352891;10908.672739817739;10753.354798712102;10818.080463160562;10819.459027048617;10819.945900270526;10828.242023058388;43146.35280470795;43503.78248108771;43600;43600.3459948101;43652.345214821806;3655.4151335786146;3873.748206366577;3903.902402439933;3959.3862951242604;4259.51015633203;30666.54000189999;32782.34435311304;33132.83433582816;33178;33305.50041749376;4419.315006174048;4491.281394976788;4518.5481451854885;4591.727947557116;4591.885202869955;336689;337239;337854;338858;341664;62757.37242627515;62926.370736292054;63282.46870125143;63342.36657633365;63715;38067.61932380696;40101.398479022835;40164;42534.361984570256;65724.34275657278;18724.438266852016;18888.33890813815;18892.33876814305;18906.338278160198;18908;13206.801897971538;13491.392887320095;14207.502737404142;14389.78415323771;14506.709865802835;19396.70904936427;19924.103415346344;20250.088746006466;20386;20390.796092039185;7348.265173482609;7365.447591430664;7518.924810751932;7564.243575642392;7623.69505219785;1024.3853687787268;1056.5773690523852;1058.0424715632364;1113.8830422805652;1114.3481063577897;32148.83925580357;32448.837755811543;32527.186820329207;32562.316642385314;32591.348173036407;1160.3038177093676;1180.167981572989;1190.000399664286;1226.399064458409;1239.9690007749878;17068.914655426644;17087.401940932006;17148.31406743741;17174.570635734206;17285;547305;550660;553397;554863;554978;59624.403755962754;60026.09960850591;60044.39955600388;60075.699621502485;60090.699546501986;1308.0843409613308;1361.516661585123;1395.2744572822278;1426;1443.4947768281227;30418.391632167677;31182.37635247237;32594.674053259165;32900.835495822364;32954;49911.500884992136;50091.49908501014;50232;50284.49715502944;50392;365859;366218;366371;368937;371111;26766;27815.30461738473;28186.85906570454;28694.42611147807;28841.56737648895;45691.77154114208;46236.7688161557;46963;47156.52843471659;48759.75620121877;39043;39346.803265983486;39483.40774888436;39725.801370994115;41058.17883642251;39784.60215397925;39828.60171398249;40483;40996.590034099274;42351;39566;39683.2063358737;39706;40504.59495405008;40703.18593628052;33919;35909.46135807913;35920.64079359173;36212.4568131473;36487.45268820917;27359.45281094407;27371.178864633297;27656.446871062868;27671;27794.861025694743 07:43:27 INFO - PROCESS | 25389 | |2;jquery.html;427.7497663866638;427.87591598436455;438.7762241256959;440.08225465165947;447.26425030824277;18342.724859127105;18916.62166756666;20131.59736805263;20133.29533466329;20319.187232510718;18895.43313700588;19014.71477927829;19144.13851376688;19161.892191858886;19357.22571097158;5590.217369568253;5848.356680765112;5849.268841394825;5850.590458667895;5851.473367396933;5611.9438805612035;5746.051901436258;5747.109198074284;5850.327212370568;5854.326752423483;5739.282589676291;5744.913826292609;5746.597738158331;5746.885062298751;5750.108733146348;5585.357683866347;5756.194132821408;5760.0783874580075;5761.078227483625;5803.448672376117;5242.135047717122;5247.501487358695;5248.448912864171;5249.685018898878;5250.921236181461;22808.65787013196;22825.77174228253;22897.198598049155;23057.769422305897;23278.53442931132;2336.217367181996;2491.1156539428425;2546.7707906288338;2679.705232424432;2724.032968296246;13686.589402317946;14321.57035288943;14371.928140359336;14477.78283325751;14580.705396251455;2014.9194032238693;2048.129544943408;2059.052835695567;2072.4093633314583;2078.251829341436;57288.427115729144;76185.61907190428;87602.12397876004;88017.99999999936;88400.55799721024;11267.605633802941;11445.713857153638;11456.4844581994;11683.591074312359;11804.11469139818;16709.582260443585;16714.4149954751;16720.832791672172;16739.16304184786;16742.83257167437;8559.828803423896;8634.093420190915;8665.306775457948;8703.260222881;8877.556122193864;8234.752957411287;8308.252257296872;8389.790255243668;8496.915030849736;8504.617292221865;4974.8756281093265;5006.424261209934;5061.240813877947;5096.949030509648;5186.792528298901;2072.3886453496257;2072.7305450291365;2120.7773183815784;2122.745270567542;2155.7305336832897;892.4288455388556;974.605284859633;1015.984015984016;1021.1014307409432;1097.6322931817772;17681.292748289925;18300.81699182991;18695.532611684815;18891.338803141825;19024;1001.6143784642965;1017.4454922067491;1018.5823812236947;1019.8776146862424;1042.3329069395593;9966;10540.9986051325;10573.841392379121;10644.840327395095;10657;491527;494971;501999;506056;536738;89351;90799;91036.54481727548;91258.54370728105;93374;1020.8060468511108;1042.2704107124891;1045.749020235138;1057.391999600233;1069.652362982034;16286.02283862972;16357.100359480342;16753.32986680519;16958;17197.656046878743;39225.607743923334;41458.37812432756;41711.58288417077;42289.78855105705;42500.5749942509;55764;55771;56022;56697.149542756066;57171.42828571661;8234.382421318305;8242.505449673039;8328.208820162075;8368.497890126611;8445.95777021111;9297.67458138962;11155.498002590066;11798.41007949582;11954;12187.634370968884;10033.397996120257;10283.897161028293;10288.794224115327;10342.741431463972;10443.843342350023;10185.541650625592;10422.374657520573;10493.317934334244;10854.34873907568;10916.454177291262;10240.18078553699;10347.12049475803;10631.458438526524;10749;10749.582787876341;8009.879851802111;8089.47418417801;8256;8360.414770966217;8477.830443391222;8264.049634292134;10218.591256349662;10328.793424131625;10357;10844.295120817122 07:43:27 INFO - PROCESS | 25389 | |3;mootools.html;1354.343143575365;1467.970640587188;1515.7574788033912;1655.6523130142668;1813.4468986958973;7862.803429914255;8716.433431826934;9001.279897608192;9004.954975225122;9325.1607355338;9104.40821346612;9191.816163676722;9193.264538836893;9194.954025229865;9206.217471514912;2483.900643974239;2514.1954574536157;2514.4845306712173;2516.2954372775653;2516.534441128388;2478.24413553866;2579.187555919889;2583.315421413327;2583.9483210335784;2585.573380392233;2434.9756502434925;2473.492933948536;2526.5199612073648;2527.0902475109037;2532.9493410131786;2384.6423036544484;2400.7839294463497;2406.819488538367;2482.987585062081;2490.439651078511;2410.8312418130736;2444.046821739523;2466.654668346433;2467.6545283660303;2494.900203991838;8785.912140878574;8996.280297576179;9003.234725048378;9065.954670226673;9109.225715814164;5440.727963601804;5672.34768001681;5701.0308247598;5701.885962280731;5706;3432.9485057724155;3528.188516641187;3589.964100359015;3609.097725568608;3615.6565126312958;1194.6475789642077;1209.1294268127021;1216.9026477881748;1223.1621339382552;1259.4017841525294;12777.488900443972;12807.295598742065;12810.615681529569;12831.35843207836;12963.28701921394;4702.15361234981;4811.3745213122775;4876.439209490883;4900.387451568554;4984.3021976923255;10120.291579589506;10129.949350253202;10132.797344053077;10137.847932281022;10138.746531336628;5628.521575666033;5639.971800140973;5644.8306550803545;5646.407127251661;5656.971715141398;4362.585554372329;4492.393526873896;4714.504976977437;5151.871203219949;5278.102722537101;3978.42312864633;4059.654929330981;4113.4446849675505;4116.567760385176;4159.9376009359885;1194.0745921910416;1222.022382094321;1228.4471987605614;1232.48235740989;1236.1532350340046;788.6569342336102;895.8163576466809;920.4753290624279;920.6363486422825;943.118184497497;5961.433663801932;6184.381561843779;6189.102580125857;6271.090691849657;6311.526635502356;483.43921051579997;485.31812803011826;486.93892932939457;503.17730510615405;509.58723434018566;4100.712950093524;4113.239050775616;4138.91722165555;4174.373843923436;4212.557681443465;10659.573617055386;10931.453427328603;11279.718007049725;11390.202685812079;11401.714957126138;10558.894411055791;10932.125429965583;11212.607558735404;11229.66311010671;11265;8069.475484093633;8159.143289954588;8384.832303353898;8431.241188293083;8432.494050356998;5829.912551311649;5984.13230081627;6039.275286965592;6156.722947467285;6179.783707570214;10356.223283253636;10387.68836934893;10396.324238924446;10401;10408;9147.679831206142;9308.720738377859;9578.856317155109;9898.059684329977;9913.058259465339;8113.432059755996;8273.131321211427;8328.417010809186;8334.374921881004;8471.915280847114;8654.870176947477;8672.739817805475;8680.348973826862;8747.993980692301;8760.12398760119;7671.923280767344;7722.227777222458;7740.919401329225;7833.138354781084;7988.161243069394;7596.126445458843;7610.505317154367;7655.157932627518;7670.654820532978;7726.9227307726205;7073.3987611053635;7204.0994875640545;7222.422206223595;7248.238934911969;7250.093738282715;5377.596680248918;5392.433794451683;5442.863928401822;5459.181122831607;5517.393086760373;5102.336696229467;5179.1195496764885;5216.426193118678;5264.289320941624;5298.178782288752 07:43:27 INFO - PROCESS | 25389 | |4;prototype.html;349.86879920029986;358.0958080845864;363.55464555919;366.25832688805167;368.1550840820317;5509.713468910402;5523.751431185597;5528.612997090206;5538.944610553894;5573.637713548616;5195.610329225314;5224.947750522494;5328.573714102862;5351.812686555972;5519.806806761764;4303.634191093761;4307.784610769465;4312.849050283241;4322.7406355618605;4351.49957754859;4295.871123866274;4325.307950727884;4327.403557865271;4327.653787696992;4334.349847522865;4073.551909289976;4234.259004674185;4254.319308910575;4266.765327906964;4302.698811083225;4244.474537650093;4253.510846252659;4255.9787201063955;4256.9574304257185;4258.23351796678;3770.8694587557943;3776.6034566370686;3787.3561494545993;3804.5624753153465;3804.5814960354337;5148.9878421123685;5268.262443257947;5289.973550132263;5301.496357845998;5316.3620365556;4860.684055536379;4862.179935637322;4882.707037577757;4882.755862206911;4897.804087836482;5609.691466969315;5656.868626274721;5665.348484924245;5671.667158217815;5690.146478028288;3946.368581027051;4141.213169497786;4153.127843152942;4177.143685544456;4192.4549808525;5833.649981001154;5854.5023672987845;5856.824295271149;5859.384764599741;5864.296284445851;4244.129953359554;4255.212785634668;4255.319148936155;4269.210196113667;4296.398504209413;4234.25900467417;4257.10600773841;4328.394024836525;4367.847125350598;4371.169477799208;4821.9035619288115;4822.445418776815;4830.7101573905675;4832.975835120872;4839.491853355417;5655.5475561954945;5658.97170514153;5676.318841739017;5704.600677952503;5718.7426565804635;1389.215093472185;1422.7296813605383;1442.935067921946;1455.9708805824037;1458.6361751762136;948.2793077261331;976.8437050071955;989.248171389749;991.3506653142204;1008.2740426892625;5260.289860868734;5293.788248470018;5323.52088312046;5336.226247194135;5344.35867695879;5588.926090650126;5612.943870561324;5615.2700148981185;5621.482199806112;5638.971805140948;5257.526822585909;5309.230161626542;5361.973190134102;5370.248165256867;5566.025945459609;2978.300099476621;3012.758979281652;3013.2015016020773;3015.62304711911;3019.74332181767;5904.232449781587;5912.556558258062;5946.375630558816;5967.8209653710455;6000.519958403404;5565.582581306418;5796.478316951495;5807.738651760681;5809.912851307234;5812.854678632983;5844.59087863854;5849.654579446751;5852.736626851717;5907.586468947218;5936.495397891227;5564.972175139098;5619.623192317908;5635.605507614428;5673.943260567342;5847.473727364388;5767.538596912321;5793.841231753582;5809.477147056785;5814.592978491465;5830.183774271521;6062.757489700362;6087.269527656709;6097.2988106366565;6103.481204097701;6120.19454261003;4167.145735124232;4194.559571244975;4316.503602085801;4320.719153255029;4356.257497001225;5726.513246374105;5750.194972703741;5854.9121763174435;5904.793332233351;5905.645661260338;5723.599348045764;5724.656520608777;5753.741081651252;5760.711964401847;5786.4991680034655;5622.522085622768;5644.576656750678;5655.830325090254;5671.659700417823;5766.567507437043;5663.960974049422;5678.574106941914;5683.232763576864;5683.618247142943;5713.628614140234;5638.520725738358;5778.353169346884;5794.18881356602;5827.854303642273;5832.679202643895;5608.214849921096;5628.240187574625;5631.549476041989;5643.407442218508;5647.322321321468 07:43:27 INFO - PROCESS | 25389 | |5;yui.html;688.5249178067133;754.7320701151094;756.6935391166579;836.126248070766;836.6820608168896;15019.624509387257;15778.842211577881;15786.605334866634;15786.84213157868;15804.44684436045;14533.273336333194;14678.853211467882;14680.706385872276;14690;14691.853081469182;716.6166101135893;739.1721272175172;841.0370126205521;845.9407841451101;859.2696208223023;852.8507511185549;855.1961156512858;855.6491838346279;855.6919508976763;856.8586183279751;893.2942975049702;895.2703546609492;895.3016647015338;896.2158111652304;896.3725392225435;894.6376717429418;895.8880139982502;897.9730608081768;898.2320116300567;899.2670973156889;657.1489920552848;658.8155316511385;658.8912829383146;659.0805825872881;659.4361820643329;13435.328233588281;13480.932595337059;13598.11612245201;13638.386272617756;14554.490592829201;14473.986820922539;14663.193524356157;14826.925865370711;15235.847641523555;15243.542693719206;11699.76600467986;11886.167968242227;11920.88079119215;11937.761244775143;11959.760804783942;3871.9612803871883;3878.0886491674432;3900.843966241347;3960.485136932209;3970.007498125469;61168.69415652893;61599.692001540156;63375.68312158456;63634.36365636377;63721.68139159321;11389.772204555862;11510.712232194262;11744;11788.23376480543;11886.227395219283;21506.247281345077;21683.67474487884;21702.89148554247;21795.237166699408;22082.116715331205;7927.850461683023;7953.12515623281;7971.322437592754;8006.279434850891;8196.918030819616;4696.178168820443;4711.1519926413575;4759.571638552547;4811.350467686818;4872.658913875995;3645.8906232813056;3727.6645101940953;3770.6417890300377;3782.0355809269013;3783.7162212834146;634.2262439823409;634.3846468925135;635.1711017122607;646.683125268615;660.6828722213364;656.186328952096;663.4294506724214;665.6205962601271;682.0349205873732;693.9757108501178;8829.33779966505;9201.90798092024;9210.769730756785;9282.582283797245;9349.298802589698;604.8457643300931;645.1902861908275;649.8960166373357;665.9800205993828;671.6138220523219;4577.290519969343;4592.839250626212;4646.605038571759;4677.111348843709;4919.458859525449;54797.45202547924;54989.175162371794;70416.29583704098;71760;73515.26484735191;72685.63657181681;72833;73275.63362183262;73755;75920;64718.35281647217;66125;67209.32790672129;67470.32529674738;69636.6518167416;9394.95302523483;9952.601895924083;9955.153811926068;10025;10201;42096.3685544711;42336.364954526325;45637.543624564656;45959.77020114878;45970.540294597966;59631;59680.40319596748;59821.70089149527;60984.695076526106;62132.68933655484;12907.225566466042;13074.673133171747;13213.471461141447;13585.116967397087;13661.590152295446;12760.74478510443;12913.94186538046;13496.190228586316;14191;14307.141571505743;13778.379972901444;13850.861491384958;13978.301084945915;14152.575422737335;14678.192699401636;12975;13349.199048057148;13378.197308161542;13851.37668804886;13937.58187254384;13060.673483162616;13391.330433478483;13607.86392136066;13650.112742671694;13679.589612311647;9739.41563506192;9892.604295828087;9905.405675659484;10186.643467478603;10301.381917084998;10607.575696972342;10649.520771565143;10656.946715266375;10799.298045627009;10823.891761082288 07:43:27 INFO - PROCESS | 25389 | __end_tp_report 07:43:27 INFO - PROCESS | 25389 | __start_cc_report 07:43:27 INFO - PROCESS | 25389 | _x_x_mozilla_cycle_collect,971 07:43:27 INFO - PROCESS | 25389 | __end_cc_report 07:43:27 INFO - PROCESS | 25389 | __startTimestamp1487087007181__endTimestamp 07:43:27 INFO - PROCESS | 25389 | 07:43:27 INFO - PROCESS | 25389 | ------- Summary: start ------- 07:43:27 INFO - PROCESS | 25389 | Number of tests: 6 07:43:27 INFO - PROCESS | 25389 | 07:43:27 INFO - PROCESS | 25389 | [#0] dojo.html Cycles:165 Average:5624.87 Median:5839.42 stddev:635.92 (10.9%) stddev-sans-first:608.89 07:43:27 INFO - PROCESS | 25389 | Values: 3205.6 3223.6 3232.9 3247.0 3275.4 5541.3 5602.1 5617.3 5617.4 5624.0 5667.2 5720.1 5733.4 5733.8 5765.9 5147.4 5184.0 5202.7 5230.3 5256.2 5063.7 5106.3 5109.9 5262.1 5289.4 5136.7 5196.5 5201.9 5226.9 5239.9 5198.0 5208.9 5215.2 5219.1 5245.7 4944.4 5038.7 5126.4 5135.6 5206.0 5467.8 5509.0 5550.2 5584.1 5608.4 5964.6 5984.7 6013.7 6019.2 6023.0 5907.6 6043.7 6048.9 6052.3 6069.6 5543.6 5611.4 5653.6 5669.8 5696.3 6225.5 6237.7 6239.0 6244.0 6246.6 5829.7 5998.7 5999.9 6005.0 6005.8 5898.1 6047.2 6080.1 6106.2 6147.1 6116.1 6119.9 6120.3 6121.0 6125.0 6063.3 6106.1 6106.3 6107.8 6134.4 4564.5 4571.0 4638.7 4678.0 4727.0 4175.7 4178.0 4192.1 4198.3 4213.7 5831.9 5832.7 5836.3 5839.4 5846.2 5916.1 5919.2 5958.3 6117.5 6143.8 5694.2 5704.4 5725.1 5743.5 5784.7 5187.9 5190.6 5206.2 5217.9 5218.5 6086.3 6214.8 6261.4 6273.1 6280.7 5876.7 5934.5 6036.4 6052.7 6078.2 6245.8 6298.7 6311.8 6351.7 6357.6 5983.0 5987.4 5988.7 5988.7 5991.1 5803.6 5940.1 6006.2 6023.2 6033.5 5886.4 5887.4 5895.4 5896.5 5900.9 5885.9 5890.2 5894.6 5894.9 5967.0 5712.8 5821.5 5823.9 5852.5 5890.1 5976.6 5982.8 5990.6 6005.0 6011.1 5642.7 5773.1 5833.7 5837.5 5842.3 07:43:27 INFO - PROCESS | 25389 | 07:43:27 INFO - PROCESS | 25389 | [#1] ext.html Cycles:180 Average:58562.89 Median:184757.21 stddev:113894.08 (61.6%) stddev-sans-first:114130.38 07:43:27 INFO - PROCESS | 25389 | Values: 580.4 631.9 644.8 660.4 666.1 33519.7 44873.0 45734.5 45817.1 45879.3 46259.5 46423.5 46640.5 46710.1 46750.5 8329.3 8897.6 9028.1 9037.1 9040.9 8349.9 10590.9 10842.9 10847.7 11157.9 10885.5 10947.0 10967.7 10969.5 10978.4 10836.8 10889.9 10893.9 10907.2 10908.7 10753.4 10818.1 10819.5 10819.9 10828.2 43146.4 43503.8 43600.0 43600.3 43652.3 3655.4 3873.7 3903.9 3959.4 4259.5 30666.5 32782.3 33132.8 33178.0 33305.5 4419.3 4491.3 4518.5 4591.7 4591.9 336689.0 337239.0 337854.0 338858.0 341664.0 62757.4 62926.4 63282.5 63342.4 63715.0 38067.6 40101.4 40164.0 42534.4 65724.3 18724.4 18888.3 18892.3 18906.3 18908.0 13206.8 13491.4 14207.5 14389.8 14506.7 19396.7 19924.1 20250.1 20386.0 20390.8 7348.3 7365.4 7518.9 7564.2 7623.7 1024.4 1056.6 1058.0 1113.9 1114.3 32148.8 32448.8 32527.2 32562.3 32591.3 1160.3 1180.2 1190.0 1226.4 1240.0 17068.9 17087.4 17148.3 17174.6 17285.0 547305.0 550660.0 553397.0 554863.0 554978.0 59624.4 60026.1 60044.4 60075.7 60090.7 1308.1 1361.5 1395.3 1426.0 1443.5 30418.4 31182.4 32594.7 32900.8 32954.0 49911.5 50091.5 50232.0 50284.5 50392.0 365859.0 366218.0 366371.0 368937.0 371111.0 26766.0 27815.3 28186.9 28694.4 28841.6 45691.8 46236.8 46963.0 47156.5 48759.8 39043.0 39346.8 39483.4 39725.8 41058.2 39784.6 39828.6 40483.0 40996.6 42351.0 39566.0 39683.2 39706.0 40504.6 40703.2 33919.0 35909.5 35920.6 36212.5 36487.5 27359.5 27371.2 27656.4 27671.0 27794.9 07:43:27 INFO - PROCESS | 25389 | 07:43:27 INFO - PROCESS | 25389 | [#2] jquery.html Cycles:180 Average:29290.00 Median:2413.67 stddev:83399.55 (3455.3%) stddev-sans-first:83605.35 07:43:27 INFO - PROCESS | 25389 | Values: 427.7 427.9 438.8 440.1 447.3 18342.7 18916.6 20131.6 20133.3 20319.2 18895.4 19014.7 19144.1 19161.9 19357.2 5590.2 5848.4 5849.3 5850.6 5851.5 5611.9 5746.1 5747.1 5850.3 5854.3 5739.3 5744.9 5746.6 5746.9 5750.1 5585.4 5756.2 5760.1 5761.1 5803.4 5242.1 5247.5 5248.4 5249.7 5250.9 22808.7 22825.8 22897.2 23057.8 23278.5 2336.2 2491.1 2546.8 2679.7 2724.0 13686.6 14321.6 14371.9 14477.8 14580.7 2014.9 2048.1 2059.1 2072.4 2078.3 57288.4 76185.6 87602.1 88018.0 88400.6 11267.6 11445.7 11456.5 11683.6 11804.1 16709.6 16714.4 16720.8 16739.2 16742.8 8559.8 8634.1 8665.3 8703.3 8877.6 8234.8 8308.3 8389.8 8496.9 8504.6 4974.9 5006.4 5061.2 5096.9 5186.8 2072.4 2072.7 2120.8 2122.7 2155.7 892.4 974.6 1016.0 1021.1 1097.6 17681.3 18300.8 18695.5 18891.3 19024.0 1001.6 1017.4 1018.6 1019.9 1042.3 9966.0 10541.0 10573.8 10644.8 10657.0 491527.0 494971.0 501999.0 506056.0 536738.0 89351.0 90799.0 91036.5 91258.5 93374.0 1020.8 1042.3 1045.7 1057.4 1069.7 16286.0 16357.1 16753.3 16958.0 17197.7 39225.6 41458.4 41711.6 42289.8 42500.6 55764.0 55771.0 56022.0 56697.1 57171.4 8234.4 8242.5 8328.2 8368.5 8446.0 9297.7 11155.5 11798.4 11954.0 12187.6 10033.4 10283.9 10288.8 10342.7 10443.8 10185.5 10422.4 10493.3 10854.3 10916.5 10240.2 10347.1 10631.5 10749.0 10749.6 8009.9 8089.5 8256.0 8360.4 8477.8 8264.0 10218.6 10328.8 10357.0 10844.3 07:43:27 INFO - PROCESS | 25389 | 07:43:27 INFO - PROCESS | 25389 | [#3] mootools.html Cycles:180 Average:5929.29 Median:2743.74 stddev:3345.20 (121.9%) stddev-sans-first:3336.91 07:43:27 INFO - PROCESS | 25389 | Values: 1354.3 1468.0 1515.8 1655.7 1813.4 7862.8 8716.4 9001.3 9005.0 9325.2 9104.4 9191.8 9193.3 9195.0 9206.2 2483.9 2514.2 2514.5 2516.3 2516.5 2478.2 2579.2 2583.3 2583.9 2585.6 2435.0 2473.5 2526.5 2527.1 2532.9 2384.6 2400.8 2406.8 2483.0 2490.4 2410.8 2444.0 2466.7 2467.7 2494.9 8785.9 8996.3 9003.2 9066.0 9109.2 5440.7 5672.3 5701.0 5701.9 5706.0 3432.9 3528.2 3590.0 3609.1 3615.7 1194.6 1209.1 1216.9 1223.2 1259.4 12777.5 12807.3 12810.6 12831.4 12963.3 4702.2 4811.4 4876.4 4900.4 4984.3 10120.3 10129.9 10132.8 10137.8 10138.7 5628.5 5640.0 5644.8 5646.4 5657.0 4362.6 4492.4 4714.5 5151.9 5278.1 3978.4 4059.7 4113.4 4116.6 4159.9 1194.1 1222.0 1228.4 1232.5 1236.2 788.7 895.8 920.5 920.6 943.1 5961.4 6184.4 6189.1 6271.1 6311.5 483.4 485.3 486.9 503.2 509.6 4100.7 4113.2 4138.9 4174.4 4212.6 10659.6 10931.5 11279.7 11390.2 11401.7 10558.9 10932.1 11212.6 11229.7 11265.0 8069.5 8159.1 8384.8 8431.2 8432.5 5829.9 5984.1 6039.3 6156.7 6179.8 10356.2 10387.7 10396.3 10401.0 10408.0 9147.7 9308.7 9578.9 9898.1 9913.1 8113.4 8273.1 8328.4 8334.4 8471.9 8654.9 8672.7 8680.3 8748.0 8760.1 7671.9 7722.2 7740.9 7833.1 7988.2 7596.1 7610.5 7655.2 7670.7 7726.9 7073.4 7204.1 7222.4 7248.2 7250.1 5377.6 5392.4 5442.9 5459.2 5517.4 5102.3 5179.1 5216.4 5264.3 5298.2 07:43:27 INFO - PROCESS | 25389 | 07:43:27 INFO - PROCESS | 25389 | [#4] prototype.html Cycles:180 Average:4791.16 Median:5521.78 stddev:1390.06 (25.2%) stddev-sans-first:1353.40 07:43:27 INFO - PROCESS | 25389 | Values: 349.9 358.1 363.6 366.3 368.2 5509.7 5523.8 5528.6 5538.9 5573.6 5195.6 5224.9 5328.6 5351.8 5519.8 4303.6 4307.8 4312.8 4322.7 4351.5 4295.9 4325.3 4327.4 4327.7 4334.3 4073.6 4234.3 4254.3 4266.8 4302.7 4244.5 4253.5 4256.0 4257.0 4258.2 3770.9 3776.6 3787.4 3804.6 3804.6 5149.0 5268.3 5290.0 5301.5 5316.4 4860.7 4862.2 4882.7 4882.8 4897.8 5609.7 5656.9 5665.3 5671.7 5690.1 3946.4 4141.2 4153.1 4177.1 4192.5 5833.6 5854.5 5856.8 5859.4 5864.3 4244.1 4255.2 4255.3 4269.2 4296.4 4234.3 4257.1 4328.4 4367.8 4371.2 4821.9 4822.4 4830.7 4833.0 4839.5 5655.5 5659.0 5676.3 5704.6 5718.7 1389.2 1422.7 1442.9 1456.0 1458.6 948.3 976.8 989.2 991.4 1008.3 5260.3 5293.8 5323.5 5336.2 5344.4 5588.9 5612.9 5615.3 5621.5 5639.0 5257.5 5309.2 5362.0 5370.2 5566.0 2978.3 3012.8 3013.2 3015.6 3019.7 5904.2 5912.6 5946.4 5967.8 6000.5 5565.6 5796.5 5807.7 5809.9 5812.9 5844.6 5849.7 5852.7 5907.6 5936.5 5565.0 5619.6 5635.6 5673.9 5847.5 5767.5 5793.8 5809.5 5814.6 5830.2 6062.8 6087.3 6097.3 6103.5 6120.2 4167.1 4194.6 4316.5 4320.7 4356.3 5726.5 5750.2 5854.9 5904.8 5905.6 5723.6 5724.7 5753.7 5760.7 5786.5 5622.5 5644.6 5655.8 5671.7 5766.6 5664.0 5678.6 5683.2 5683.6 5713.6 5638.5 5778.4 5794.2 5827.9 5832.7 5608.2 5628.2 5631.5 5643.4 5647.3 07:43:27 INFO - PROCESS | 25389 | 07:43:27 INFO - PROCESS | 25389 | [#5] yui.html Cycles:180 Average:17145.43 Median:4785.46 stddev:21337.62 (445.9%) stddev-sans-first:21361.69 07:43:27 INFO - PROCESS | 25389 | Values: 688.5 754.7 756.7 836.1 836.7 15019.6 15778.8 15786.6 15786.8 15804.4 14533.3 14678.9 14680.7 14690.0 14691.9 716.6 739.2 841.0 845.9 859.3 852.9 855.2 855.6 855.7 856.9 893.3 895.3 895.3 896.2 896.4 894.6 895.9 898.0 898.2 899.3 657.1 658.8 658.9 659.1 659.4 13435.3 13480.9 13598.1 13638.4 14554.5 14474.0 14663.2 14826.9 15235.8 15243.5 11699.8 11886.2 11920.9 11937.8 11959.8 3872.0 3878.1 3900.8 3960.5 3970.0 61168.7 61599.7 63375.7 63634.4 63721.7 11389.8 11510.7 11744.0 11788.2 11886.2 21506.2 21683.7 21702.9 21795.2 22082.1 7927.9 7953.1 7971.3 8006.3 8196.9 4696.2 4711.2 4759.6 4811.4 4872.7 3645.9 3727.7 3770.6 3782.0 3783.7 634.2 634.4 635.2 646.7 660.7 656.2 663.4 665.6 682.0 694.0 8829.3 9201.9 9210.8 9282.6 9349.3 604.8 645.2 649.9 666.0 671.6 4577.3 4592.8 4646.6 4677.1 4919.5 54797.5 54989.2 70416.3 71760.0 73515.3 72685.6 72833.0 73275.6 73755.0 75920.0 64718.4 66125.0 67209.3 67470.3 69636.7 9395.0 9952.6 9955.2 10025.0 10201.0 42096.4 42336.4 45637.5 45959.8 45970.5 59631.0 59680.4 59821.7 60984.7 62132.7 12907.2 13074.7 13213.5 13585.1 13661.6 12760.7 12913.9 13496.2 14191.0 14307.1 13778.4 13850.9 13978.3 14152.6 14678.2 12975.0 13349.2 13378.2 13851.4 13937.6 13060.7 13391.3 13607.9 13650.1 13679.6 9739.4 9892.6 9905.4 10186.6 10301.4 10607.6 10649.5 10656.9 10799.3 10823.9 07:43:27 INFO - PROCESS | 25389 | -------- Summary: end -------- 07:43:27 INFO - PROCESS | 25389 | 07:43:27 INFO - TEST-INFO | 25389: exit 0 07:43:27 INFO - TEST-OK | dromaeo_css | took 1114507ms 07:43:27 INFO - TEST-START | kraken 07:43:27 INFO - operating with platform_type : linux_ 07:43:27 INFO - Initialising browser for kraken test... 07:43:27 INFO - TEST-INFO | started process 25695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpebUBP8/profile http://localhost:44396/getInfo.html) 07:43:31 INFO - PROCESS | 25695 | __metrics Screen width/height:1600/1200 07:43:31 INFO - PROCESS | 25695 | colorDepth:24 07:43:31 INFO - PROCESS | 25695 | Browser inner width/height: 1024/697 07:43:31 INFO - PROCESS | 25695 | __metrics 07:43:32 INFO - PROCESS | 25695 | 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" 07:43:32 INFO - PROCESS | 25695 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:43:32 INFO - PROCESS | 25695 | console.error: PushService: 07:43:32 INFO - PROCESS | 25695 | stateChangeProcessEnqueue: Error transitioning state 07:43:32 INFO - PROCESS | 25695 | UnknownError 07:43:33 INFO - TEST-INFO | 25695: exit 0 07:43:33 INFO - Browser initialized. 07:43:33 INFO - Running cycle 1/1 for kraken test... 07:43:33 INFO - TEST-INFO | started process 25786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpebUBP8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:43:45 INFO - PROCESS | 25786 | RSS: Main: 142180352 07:43:45 INFO - PROCESS | 25786 | 07:43:47 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44396/tests/kraken/driver.html?testName=audio-beat-detection) 07:43:48 INFO - PROCESS | 25786 | RSS: Main: 183250944 07:43:48 INFO - PROCESS | 25786 | 07:43:50 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44396/tests/kraken/driver.html?testName=audio-dft) 07:43:51 INFO - PROCESS | 25786 | RSS: Main: 173744128 07:43:51 INFO - PROCESS | 25786 | 07:43:54 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44396/tests/kraken/driver.html?testName=audio-fft) 07:43:54 INFO - PROCESS | 25786 | RSS: Main: 264224768 07:43:54 INFO - PROCESS | 25786 | 07:43:56 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44396/tests/kraken/driver.html?testName=audio-oscillator) 07:43:57 INFO - PROCESS | 25786 | RSS: Main: 171188224 07:43:57 INFO - PROCESS | 25786 | 07:43:59 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44396/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:44:00 INFO - PROCESS | 25786 | RSS: Main: 173481984 07:44:00 INFO - PROCESS | 25786 | 07:44:03 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44396/tests/kraken/driver.html?testName=imaging-darkroom) 07:44:03 INFO - PROCESS | 25786 | RSS: Main: 211599360 07:44:03 INFO - PROCESS | 25786 | 07:44:07 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44396/tests/kraken/driver.html?testName=imaging-desaturate) 07:44:07 INFO - PROCESS | 25786 | RSS: Main: 211025920 07:44:07 INFO - PROCESS | 25786 | 07:44:10 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44396/tests/kraken/driver.html?testName=json-parse-financial) 07:44:10 INFO - PROCESS | 25786 | RSS: Main: 209805312 07:44:10 INFO - PROCESS | 25786 | 07:44:12 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44396/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:44:12 INFO - PROCESS | 25786 | RSS: Main: 171704320 07:44:12 INFO - PROCESS | 25786 | 07:44:14 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44396/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:44:15 INFO - PROCESS | 25786 | RSS: Main: 178769920 07:44:15 INFO - PROCESS | 25786 | 07:44:17 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44396/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:44:17 INFO - PROCESS | 25786 | RSS: Main: 188637184 07:44:17 INFO - PROCESS | 25786 | 07:44:20 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:44:21 INFO - PROCESS | 25786 | RSS: Main: 195977216 07:44:21 INFO - PROCESS | 25786 | 07:44:23 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:44:24 INFO - PROCESS | 25786 | RSS: Main: 192995328 07:44:24 INFO - PROCESS | 25786 | 07:44:26 INFO - PROCESS | 25786 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44396/tests/kraken/driver.html?testName=ai-astar) 07:44:26 INFO - PROCESS | 25786 | RSS: Main: 244391936 07:44:26 INFO - PROCESS | 25786 | 07:44:26 INFO - PROCESS | 25786 | __start_tp_report 07:44:26 INFO - PROCESS | 25786 | _x_x_mozilla_page_load 07:44:26 INFO - PROCESS | 25786 | _x_x_mozilla_page_load_details 07:44:26 INFO - PROCESS | 25786 | |i|pagename|runs| 07:44:26 INFO - PROCESS | 25786 | |0;ai-astar;100;110;110;109;111;112;111;110;110;110 07:44:26 INFO - PROCESS | 25786 | |1;audio-beat-detection;141;116;117;150;124;125;121;119;150;118 07:44:26 INFO - PROCESS | 25786 | |2;audio-dft;160;160;161;161;161;159;161;161;161;159 07:44:26 INFO - PROCESS | 25786 | |3;audio-fft;74;74;76;110;75;75;81;75;97;76 07:44:26 INFO - PROCESS | 25786 | |4;audio-oscillator;81;82;109;83;82;82;99;81;83;115 07:44:26 INFO - PROCESS | 25786 | |5;imaging-gaussian-blur;117;116;117;117;118;117;116;117;118;118 07:44:26 INFO - PROCESS | 25786 | |6;imaging-darkroom;146;146;146;145;146;146;146;145;146;147 07:44:26 INFO - PROCESS | 25786 | |7;imaging-desaturate;84;85;85;84;84;84;85;84;85;85 07:44:26 INFO - PROCESS | 25786 | |8;json-parse-financial;53;53;52;53;51;52;53;52;51;52 07:44:26 INFO - PROCESS | 25786 | |9;json-stringify-tinderbox;60;61;60;61;62;62;60;61;61;60 07:44:26 INFO - PROCESS | 25786 | |10;stanford-crypto-aes;75;75;76;75;75;74;80;80;74;75 07:44:26 INFO - PROCESS | 25786 | |11;stanford-crypto-ccm;129;127;121;121;136;122;121;121;155;122 07:44:26 INFO - PROCESS | 25786 | |12;stanford-crypto-pbkdf2;156;162;155;154;154;156;157;156;155;155 07:44:26 INFO - PROCESS | 25786 | |13;stanford-crypto-sha256-iterative;62;64;63;63;63;64;63;63;62;62 07:44:26 INFO - PROCESS | 25786 | __end_tp_report 07:44:26 INFO - PROCESS | 25786 | __start_cc_report 07:44:26 INFO - PROCESS | 25786 | _x_x_mozilla_cycle_collect,1573 07:44:26 INFO - PROCESS | 25786 | __end_cc_report 07:44:26 INFO - PROCESS | 25786 | __startTimestamp1487087066256__endTimestamp 07:44:26 INFO - PROCESS | 25786 | 07:44:26 INFO - PROCESS | 25786 | ------- Summary: start ------- 07:44:26 INFO - PROCESS | 25786 | Number of tests: 14 07:44:26 INFO - PROCESS | 25786 | 07:44:26 INFO - PROCESS | 25786 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:3.37 (3.1%) stddev-sans-first:0.87 07:44:26 INFO - PROCESS | 25786 | Values: 100.0 110.0 110.0 109.0 111.0 112.0 111.0 110.0 110.0 110.0 07:44:26 INFO - PROCESS | 25786 | 07:44:26 INFO - PROCESS | 25786 | [#1] audio-beat-detection Cycles:10 Average:128.10 Median:124.50 stddev:13.57 (10.9%) stddev-sans-first:13.56 07:44:26 INFO - PROCESS | 25786 | Values: 141.0 116.0 117.0 150.0 124.0 125.0 121.0 119.0 150.0 118.0 07:44:26 INFO - PROCESS | 25786 | 07:44:26 INFO - PROCESS | 25786 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.84 (0.5%) stddev-sans-first:0.88 07:44:26 INFO - PROCESS | 25786 | Values: 160.0 160.0 161.0 161.0 161.0 159.0 161.0 161.0 161.0 159.0 07:44:26 INFO - PROCESS | 25786 | 07:44:26 INFO - PROCESS | 25786 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.50 stddev:12.26 (16.2%) stddev-sans-first:12.71 07:44:26 INFO - PROCESS | 25786 | Values: 74.0 74.0 76.0 110.0 75.0 75.0 81.0 75.0 97.0 76.0 07:44:26 INFO - PROCESS | 25786 | 07:44:26 INFO - PROCESS | 25786 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:82.00 stddev:12.99 (15.8%) stddev-sans-first:13.39 07:44:26 INFO - PROCESS | 25786 | Values: 81.0 82.0 109.0 83.0 82.0 82.0 99.0 81.0 83.0 115.0 07:44:26 INFO - PROCESS | 25786 | 07:44:26 INFO - PROCESS | 25786 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 07:44:26 INFO - PROCESS | 25786 | Values: 117.0 116.0 117.0 117.0 118.0 117.0 116.0 117.0 118.0 118.0 07:44:26 INFO - PROCESS | 25786 | 07:44:26 INFO - PROCESS | 25786 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 07:44:26 INFO - PROCESS | 25786 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 147.0 07:44:26 INFO - PROCESS | 25786 | 07:44:26 INFO - PROCESS | 25786 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 07:44:26 INFO - PROCESS | 25786 | Values: 84.0 85.0 85.0 84.0 84.0 84.0 85.0 84.0 85.0 85.0 07:44:26 INFO - PROCESS | 25786 | 07:44:26 INFO - PROCESS | 25786 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.50 stddev:0.79 (1.5%) stddev-sans-first:0.78 07:44:26 INFO - PROCESS | 25786 | Values: 53.0 53.0 52.0 53.0 51.0 52.0 53.0 52.0 51.0 52.0 07:44:26 INFO - PROCESS | 25786 | 07:44:26 INFO - PROCESS | 25786 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 07:44:26 INFO - PROCESS | 25786 | Values: 60.0 61.0 60.0 61.0 62.0 62.0 60.0 61.0 61.0 60.0 07:44:26 INFO - PROCESS | 25786 | 07:44:26 INFO - PROCESS | 25786 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:75.00 stddev:2.23 (3.0%) stddev-sans-first:2.35 07:44:26 INFO - PROCESS | 25786 | Values: 75.0 75.0 76.0 75.0 75.0 74.0 80.0 80.0 74.0 75.0 07:44:26 INFO - PROCESS | 25786 | 07:44:26 INFO - PROCESS | 25786 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:124.50 stddev:10.86 (8.7%) stddev-sans-first:11.50 07:44:26 INFO - PROCESS | 25786 | Values: 129.0 127.0 121.0 121.0 136.0 122.0 121.0 121.0 155.0 122.0 07:44:26 INFO - PROCESS | 25786 | 07:44:26 INFO - PROCESS | 25786 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.00 Median:156.00 stddev:2.31 (1.5%) stddev-sans-first:2.45 07:44:26 INFO - PROCESS | 25786 | Values: 156.0 162.0 155.0 154.0 154.0 156.0 157.0 156.0 155.0 155.0 07:44:26 INFO - PROCESS | 25786 | 07:44:26 INFO - PROCESS | 25786 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 07:44:26 INFO - PROCESS | 25786 | Values: 62.0 64.0 63.0 63.0 63.0 64.0 63.0 63.0 62.0 62.0 07:44:26 INFO - PROCESS | 25786 | -------- Summary: end -------- 07:44:26 INFO - PROCESS | 25786 | 07:44:27 INFO - TEST-INFO | 25786: exit 0 07:44:27 INFO - TEST-OK | kraken | took 59435ms 07:44:27 INFO - SUITE-END | took 1173s 07:44:27 INFO - Completed test suite (00:19:34) 07:44:27 INFO - javascript benchmark 07:44:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3205.615326160861, 3223.6131664200298, 3232.9191770205744, 3247.0, 3275.4431746603077, 5541.307336582927, 5602.131669591215, 5617.325920889499, 5617.4382561743905, 5624.0439125348685, 5667.178259152421, 5720.084786434171, 5733.397993210715, 5733.770649174038, 5765.942340576593, 5147.408048074463, 5183.974080129594, 5202.687838729688, 5230.293910322096, 5256.211568264753, 5063.696178229299, 5106.259592359106, 5109.897802043957, 5262.05283049051, 5289.391719952197, 5136.717480538568, 5196.532312091911, 5201.86995325118, 5226.947730522684, 5239.895202095956, 5198.0383629028565, 5208.921866172011, 5215.243789650517, 5219.086659834514, 5245.711485868275, 4944.431390390079, 5038.748062596856, 5126.384833819965, 5135.589152867761, 5205.973970130163, 5467.808626698086, 5509.035918714209, 5550.16747487876, 5584.106542953108, 5608.4111168327145, 5964.642121472682, 5984.670843103628, 6013.6993150342305, 6019.187409699722, 6022.969885150546, 5907.556933230025, 6043.6675982820925, 6048.939510604881, 6052.273727152726, 6069.635821850703, 5543.584231182677, 5611.3546942101775, 5653.632513886584, 5669.773209071591, 5696.287964004499, 6225.501959843202, 6237.656928868865, 6238.968805155945, 6244.0, 6246.562740608114, 5829.679367634736, 5998.700064996733, 5999.850003749942, 6005.0, 6005.759769609254, 5898.056310990307, 6047.15339852421, 6080.0575910733905, 6106.2061931948565, 6147.0779383092, 6116.119654120117, 6119.898632333103, 6120.2610859299775, 6120.975172448212, 6124.971343706056, 6063.272407311063, 6106.145139680449, 6106.297775755756, 6107.8473038173515, 6134.35589263121, 4564.497905230422, 4570.977145114253, 4638.698484598558, 4678.0410015946645, 4727.030958653468, 4175.707700460938, 4178.039051018222, 4192.11965487245, 4198.307279298942, 4213.705040647125, 5831.912521312183, 5832.679202643811, 5836.328822185503, 5839.416058394127, 5846.210761547137, 5916.142159386951, 5919.1713160157615, 5958.2850057992455, 6117.510599152057, 6143.815685529441, 5694.174344719992, 5704.4295570443455, 5725.083986562214, 5743.483086522149, 5784.652920824764, 5187.870303242449, 5190.6366554341585, 5206.219067139959, 5217.895642087137, 5218.452062533379, 6086.330503644507, 6214.751409943642, 6261.436470717657, 6273.059041143865, 6280.717367718372, 5876.706164691834, 5934.465898069195, 6036.396360363929, 6052.66710330936, 6078.179445774764, 6245.843853903689, 6298.685065746786, 6311.842203944754, 6351.650659213788, 6357.554971151975, 5983.0, 5987.371326010706, 5988.716333406424, 5988.730507127103, 5991.131285963424, 5803.622764520462, 5940.138679891478, 6006.159137720635, 6023.216981792339, 6033.487153591994, 5886.411358864079, 5887.4406931341455, 5895.41045895407, 5896.469317761422, 5900.881982360414, 5885.852853678693, 5890.2342695449315, 5894.616849904743, 5894.941050589439, 5967.0, 5712.828615141552, 5821.505172060253, 5823.8835223294445, 5852.531797456279, 5890.057590785454, 5976.551758618034, 5982.760689572542, 5990.610610310316, 6004.979153543995, 6011.128386383863, 5642.746076426489, 5773.076307790733, 5833.737481813244, 5837.5329973601165, 5842.328132264844], "value": 5581.849699244674, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.4079838564664, 631.8862604731148, 644.761438267841, 660.3693472733537, 666.0542030316949, 33519.66480335196, 44873.0, 45734.542654573444, 45817.08365832681, 45879.31181032283, 46259.537404625946, 46423.53576464234, 46640.53359466404, 46710.06579868409, 46750.53249467504, 8329.250367466926, 8897.555122243893, 9028.052054534244, 9037.141471560191, 9040.909590904073, 8349.916500835005, 10590.947045264802, 10842.891571084267, 10847.67456976288, 11157.888421115766, 10885.455727213648, 10947.0, 10967.670969870876, 10969.506372213229, 10978.396188209645, 10836.783264334708, 10889.891101088966, 10893.891061089407, 10907.181961352891, 10908.672739817739, 10753.354798712102, 10818.080463160562, 10819.459027048617, 10819.945900270526, 10828.242023058388, 43146.35280470795, 43503.78248108771, 43600.0, 43600.3459948101, 43652.345214821806, 3655.4151335786146, 3873.748206366577, 3903.902402439933, 3959.3862951242604, 4259.51015633203, 30666.54000189999, 32782.34435311304, 33132.83433582816, 33178.0, 33305.50041749376, 4419.315006174048, 4491.281394976788, 4518.5481451854885, 4591.727947557116, 4591.885202869955, 336689.0, 337239.0, 337854.0, 338858.0, 341664.0, 62757.37242627515, 62926.370736292054, 63282.46870125143, 63342.36657633365, 63715.0, 38067.61932380696, 40101.398479022835, 40164.0, 42534.361984570256, 65724.34275657278, 18724.438266852016, 18888.33890813815, 18892.33876814305, 18906.338278160198, 18908.0, 13206.801897971538, 13491.392887320095, 14207.502737404142, 14389.78415323771, 14506.709865802835, 19396.70904936427, 19924.103415346344, 20250.088746006466, 20386.0, 20390.796092039185, 7348.265173482609, 7365.447591430664, 7518.924810751932, 7564.243575642392, 7623.69505219785, 1024.3853687787268, 1056.5773690523852, 1058.0424715632364, 1113.8830422805652, 1114.3481063577897, 32148.83925580357, 32448.837755811543, 32527.186820329207, 32562.316642385314, 32591.348173036407, 1160.3038177093676, 1180.167981572989, 1190.000399664286, 1226.399064458409, 1239.9690007749878, 17068.914655426644, 17087.401940932006, 17148.31406743741, 17174.570635734206, 17285.0, 547305.0, 550660.0, 553397.0, 554863.0, 554978.0, 59624.403755962754, 60026.09960850591, 60044.39955600388, 60075.699621502485, 60090.699546501986, 1308.0843409613308, 1361.516661585123, 1395.2744572822278, 1426.0, 1443.4947768281227, 30418.391632167677, 31182.37635247237, 32594.674053259165, 32900.835495822364, 32954.0, 49911.500884992136, 50091.49908501014, 50232.0, 50284.49715502944, 50392.0, 365859.0, 366218.0, 366371.0, 368937.0, 371111.0, 26766.0, 27815.30461738473, 28186.85906570454, 28694.42611147807, 28841.56737648895, 45691.77154114208, 46236.7688161557, 46963.0, 47156.52843471659, 48759.75620121877, 39043.0, 39346.803265983486, 39483.40774888436, 39725.801370994115, 41058.17883642251, 39784.60215397925, 39828.60171398249, 40483.0, 40996.590034099274, 42351.0, 39566.0, 39683.2063358737, 39706.0, 40504.59495405008, 40703.18593628052, 33919.0, 35909.46135807913, 35920.64079359173, 36212.4568131473, 36487.45268820917, 27359.45281094407, 27371.178864633297, 27656.446871062868, 27671.0, 27794.861025694743], "value": 20706.719260307415, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.7497663866638, 427.87591598436455, 438.7762241256959, 440.08225465165947, 447.26425030824277, 18342.724859127105, 18916.62166756666, 20131.59736805263, 20133.29533466329, 20319.187232510718, 18895.43313700588, 19014.71477927829, 19144.13851376688, 19161.892191858886, 19357.22571097158, 5590.217369568253, 5848.356680765112, 5849.268841394825, 5850.590458667895, 5851.473367396933, 5611.9438805612035, 5746.051901436258, 5747.109198074284, 5850.327212370568, 5854.326752423483, 5739.282589676291, 5744.913826292609, 5746.597738158331, 5746.885062298751, 5750.108733146348, 5585.357683866347, 5756.194132821408, 5760.0783874580075, 5761.078227483625, 5803.448672376117, 5242.135047717122, 5247.501487358695, 5248.448912864171, 5249.685018898878, 5250.921236181461, 22808.65787013196, 22825.77174228253, 22897.198598049155, 23057.769422305897, 23278.53442931132, 2336.217367181996, 2491.1156539428425, 2546.7707906288338, 2679.705232424432, 2724.032968296246, 13686.589402317946, 14321.57035288943, 14371.928140359336, 14477.78283325751, 14580.705396251455, 2014.9194032238693, 2048.129544943408, 2059.052835695567, 2072.4093633314583, 2078.251829341436, 57288.427115729144, 76185.61907190428, 87602.12397876004, 88017.99999999936, 88400.55799721024, 11267.605633802941, 11445.713857153638, 11456.4844581994, 11683.591074312359, 11804.11469139818, 16709.582260443585, 16714.4149954751, 16720.832791672172, 16739.16304184786, 16742.83257167437, 8559.828803423896, 8634.093420190915, 8665.306775457948, 8703.260222881, 8877.556122193864, 8234.752957411287, 8308.252257296872, 8389.790255243668, 8496.915030849736, 8504.617292221865, 4974.8756281093265, 5006.424261209934, 5061.240813877947, 5096.949030509648, 5186.792528298901, 2072.3886453496257, 2072.7305450291365, 2120.7773183815784, 2122.745270567542, 2155.7305336832897, 892.4288455388556, 974.605284859633, 1015.984015984016, 1021.1014307409432, 1097.6322931817772, 17681.292748289925, 18300.81699182991, 18695.532611684815, 18891.338803141825, 19024.0, 1001.6143784642965, 1017.4454922067491, 1018.5823812236947, 1019.8776146862424, 1042.3329069395593, 9966.0, 10540.9986051325, 10573.841392379121, 10644.840327395095, 10657.0, 491527.0, 494971.0, 501999.0, 506056.0, 536738.0, 89351.0, 90799.0, 91036.54481727548, 91258.54370728105, 93374.0, 1020.8060468511108, 1042.2704107124891, 1045.749020235138, 1057.391999600233, 1069.652362982034, 16286.02283862972, 16357.100359480342, 16753.32986680519, 16958.0, 17197.656046878743, 39225.607743923334, 41458.37812432756, 41711.58288417077, 42289.78855105705, 42500.5749942509, 55764.0, 55771.0, 56022.0, 56697.149542756066, 57171.42828571661, 8234.382421318305, 8242.505449673039, 8328.208820162075, 8368.497890126611, 8445.95777021111, 9297.67458138962, 11155.498002590066, 11798.41007949582, 11954.0, 12187.634370968884, 10033.397996120257, 10283.897161028293, 10288.794224115327, 10342.741431463972, 10443.843342350023, 10185.541650625592, 10422.374657520573, 10493.317934334244, 10854.34873907568, 10916.454177291262, 10240.18078553699, 10347.12049475803, 10631.458438526524, 10749.0, 10749.582787876341, 8009.879851802111, 8089.47418417801, 8256.0, 8360.414770966217, 8477.830443391222, 8264.049634292134, 10218.591256349662, 10328.793424131625, 10357.0, 10844.295120817122], "value": 9266.585071097903, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.343143575365, 1467.970640587188, 1515.7574788033912, 1655.6523130142668, 1813.4468986958973, 7862.803429914255, 8716.433431826934, 9001.279897608192, 9004.954975225122, 9325.1607355338, 9104.40821346612, 9191.816163676722, 9193.264538836893, 9194.954025229865, 9206.217471514912, 2483.900643974239, 2514.1954574536157, 2514.4845306712173, 2516.2954372775653, 2516.534441128388, 2478.24413553866, 2579.187555919889, 2583.315421413327, 2583.9483210335784, 2585.573380392233, 2434.9756502434925, 2473.492933948536, 2526.5199612073648, 2527.0902475109037, 2532.9493410131786, 2384.6423036544484, 2400.7839294463497, 2406.819488538367, 2482.987585062081, 2490.439651078511, 2410.8312418130736, 2444.046821739523, 2466.654668346433, 2467.6545283660303, 2494.900203991838, 8785.912140878574, 8996.280297576179, 9003.234725048378, 9065.954670226673, 9109.225715814164, 5440.727963601804, 5672.34768001681, 5701.0308247598, 5701.885962280731, 5706.0, 3432.9485057724155, 3528.188516641187, 3589.964100359015, 3609.097725568608, 3615.6565126312958, 1194.6475789642077, 1209.1294268127021, 1216.9026477881748, 1223.1621339382552, 1259.4017841525294, 12777.488900443972, 12807.295598742065, 12810.615681529569, 12831.35843207836, 12963.28701921394, 4702.15361234981, 4811.3745213122775, 4876.439209490883, 4900.387451568554, 4984.3021976923255, 10120.291579589506, 10129.949350253202, 10132.797344053077, 10137.847932281022, 10138.746531336628, 5628.521575666033, 5639.971800140973, 5644.8306550803545, 5646.407127251661, 5656.971715141398, 4362.585554372329, 4492.393526873896, 4714.504976977437, 5151.871203219949, 5278.102722537101, 3978.42312864633, 4059.654929330981, 4113.4446849675505, 4116.567760385176, 4159.9376009359885, 1194.0745921910416, 1222.022382094321, 1228.4471987605614, 1232.48235740989, 1236.1532350340046, 788.6569342336102, 895.8163576466809, 920.4753290624279, 920.6363486422825, 943.118184497497, 5961.433663801932, 6184.381561843779, 6189.102580125857, 6271.090691849657, 6311.526635502356, 483.43921051579997, 485.31812803011826, 486.93892932939457, 503.17730510615405, 509.58723434018566, 4100.712950093524, 4113.239050775616, 4138.91722165555, 4174.373843923436, 4212.557681443465, 10659.573617055386, 10931.453427328603, 11279.718007049725, 11390.202685812079, 11401.714957126138, 10558.894411055791, 10932.125429965583, 11212.607558735404, 11229.66311010671, 11265.0, 8069.475484093633, 8159.143289954588, 8384.832303353898, 8431.241188293083, 8432.494050356998, 5829.912551311649, 5984.13230081627, 6039.275286965592, 6156.722947467285, 6179.783707570214, 10356.223283253636, 10387.68836934893, 10396.324238924446, 10401.0, 10408.0, 9147.679831206142, 9308.720738377859, 9578.856317155109, 9898.059684329977, 9913.058259465339, 8113.432059755996, 8273.131321211427, 8328.417010809186, 8334.374921881004, 8471.915280847114, 8654.870176947477, 8672.739817805475, 8680.348973826862, 8747.993980692301, 8760.12398760119, 7671.923280767344, 7722.227777222458, 7740.919401329225, 7833.138354781084, 7988.161243069394, 7596.126445458843, 7610.505317154367, 7655.157932627518, 7670.654820532978, 7726.9227307726205, 7073.3987611053635, 7204.0994875640545, 7222.422206223595, 7248.238934911969, 7250.093738282715, 5377.596680248918, 5392.433794451683, 5442.863928401822, 5459.181122831607, 5517.393086760373, 5102.336696229467, 5179.1195496764885, 5216.426193118678, 5264.289320941624, 5298.178782288752], "value": 4684.267347332073, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.86879920029986, 358.0958080845864, 363.55464555919, 366.25832688805167, 368.1550840820317, 5509.713468910402, 5523.751431185597, 5528.612997090206, 5538.944610553894, 5573.637713548616, 5195.610329225314, 5224.947750522494, 5328.573714102862, 5351.812686555972, 5519.806806761764, 4303.634191093761, 4307.784610769465, 4312.849050283241, 4322.7406355618605, 4351.49957754859, 4295.871123866274, 4325.307950727884, 4327.403557865271, 4327.653787696992, 4334.349847522865, 4073.551909289976, 4234.259004674185, 4254.319308910575, 4266.765327906964, 4302.698811083225, 4244.474537650093, 4253.510846252659, 4255.9787201063955, 4256.9574304257185, 4258.23351796678, 3770.8694587557943, 3776.6034566370686, 3787.3561494545993, 3804.5624753153465, 3804.5814960354337, 5148.9878421123685, 5268.262443257947, 5289.973550132263, 5301.496357845998, 5316.3620365556, 4860.684055536379, 4862.179935637322, 4882.707037577757, 4882.755862206911, 4897.804087836482, 5609.691466969315, 5656.868626274721, 5665.348484924245, 5671.667158217815, 5690.146478028288, 3946.368581027051, 4141.213169497786, 4153.127843152942, 4177.143685544456, 4192.4549808525, 5833.649981001154, 5854.5023672987845, 5856.824295271149, 5859.384764599741, 5864.296284445851, 4244.129953359554, 4255.212785634668, 4255.319148936155, 4269.210196113667, 4296.398504209413, 4234.25900467417, 4257.10600773841, 4328.394024836525, 4367.847125350598, 4371.169477799208, 4821.9035619288115, 4822.445418776815, 4830.7101573905675, 4832.975835120872, 4839.491853355417, 5655.5475561954945, 5658.97170514153, 5676.318841739017, 5704.600677952503, 5718.7426565804635, 1389.215093472185, 1422.7296813605383, 1442.935067921946, 1455.9708805824037, 1458.6361751762136, 948.2793077261331, 976.8437050071955, 989.248171389749, 991.3506653142204, 1008.2740426892625, 5260.289860868734, 5293.788248470018, 5323.52088312046, 5336.226247194135, 5344.35867695879, 5588.926090650126, 5612.943870561324, 5615.2700148981185, 5621.482199806112, 5638.971805140948, 5257.526822585909, 5309.230161626542, 5361.973190134102, 5370.248165256867, 5566.025945459609, 2978.300099476621, 3012.758979281652, 3013.2015016020773, 3015.62304711911, 3019.74332181767, 5904.232449781587, 5912.556558258062, 5946.375630558816, 5967.8209653710455, 6000.519958403404, 5565.582581306418, 5796.478316951495, 5807.738651760681, 5809.912851307234, 5812.854678632983, 5844.59087863854, 5849.654579446751, 5852.736626851717, 5907.586468947218, 5936.495397891227, 5564.972175139098, 5619.623192317908, 5635.605507614428, 5673.943260567342, 5847.473727364388, 5767.538596912321, 5793.841231753582, 5809.477147056785, 5814.592978491465, 5830.183774271521, 6062.757489700362, 6087.269527656709, 6097.2988106366565, 6103.481204097701, 6120.19454261003, 4167.145735124232, 4194.559571244975, 4316.503602085801, 4320.719153255029, 4356.257497001225, 5726.513246374105, 5750.194972703741, 5854.9121763174435, 5904.793332233351, 5905.645661260338, 5723.599348045764, 5724.656520608777, 5753.741081651252, 5760.711964401847, 5786.4991680034655, 5622.522085622768, 5644.576656750678, 5655.830325090254, 5671.659700417823, 5766.567507437043, 5663.960974049422, 5678.574106941914, 5683.232763576864, 5683.618247142943, 5713.628614140234, 5638.520725738358, 5778.353169346884, 5794.18881356602, 5827.854303642273, 5832.679202643895, 5608.214849921096, 5628.240187574625, 5631.549476041989, 5643.407442218508, 5647.322321321468], "value": 4352.542302150144, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.5249178067133, 754.7320701151094, 756.6935391166579, 836.126248070766, 836.6820608168896, 15019.624509387257, 15778.842211577881, 15786.605334866634, 15786.84213157868, 15804.44684436045, 14533.273336333194, 14678.853211467882, 14680.706385872276, 14690.0, 14691.853081469182, 716.6166101135893, 739.1721272175172, 841.0370126205521, 845.9407841451101, 859.2696208223023, 852.8507511185549, 855.1961156512858, 855.6491838346279, 855.6919508976763, 856.8586183279751, 893.2942975049702, 895.2703546609492, 895.3016647015338, 896.2158111652304, 896.3725392225435, 894.6376717429418, 895.8880139982502, 897.9730608081768, 898.2320116300567, 899.2670973156889, 657.1489920552848, 658.8155316511385, 658.8912829383146, 659.0805825872881, 659.4361820643329, 13435.328233588281, 13480.932595337059, 13598.11612245201, 13638.386272617756, 14554.490592829201, 14473.986820922539, 14663.193524356157, 14826.925865370711, 15235.847641523555, 15243.542693719206, 11699.76600467986, 11886.167968242227, 11920.88079119215, 11937.761244775143, 11959.760804783942, 3871.9612803871883, 3878.0886491674432, 3900.843966241347, 3960.485136932209, 3970.007498125469, 61168.69415652893, 61599.692001540156, 63375.68312158456, 63634.36365636377, 63721.68139159321, 11389.772204555862, 11510.712232194262, 11744.0, 11788.23376480543, 11886.227395219283, 21506.247281345077, 21683.67474487884, 21702.89148554247, 21795.237166699408, 22082.116715331205, 7927.850461683023, 7953.12515623281, 7971.322437592754, 8006.279434850891, 8196.918030819616, 4696.178168820443, 4711.1519926413575, 4759.571638552547, 4811.350467686818, 4872.658913875995, 3645.8906232813056, 3727.6645101940953, 3770.6417890300377, 3782.0355809269013, 3783.7162212834146, 634.2262439823409, 634.3846468925135, 635.1711017122607, 646.683125268615, 660.6828722213364, 656.186328952096, 663.4294506724214, 665.6205962601271, 682.0349205873732, 693.9757108501178, 8829.33779966505, 9201.90798092024, 9210.769730756785, 9282.582283797245, 9349.298802589698, 604.8457643300931, 645.1902861908275, 649.8960166373357, 665.9800205993828, 671.6138220523219, 4577.290519969343, 4592.839250626212, 4646.605038571759, 4677.111348843709, 4919.458859525449, 54797.45202547924, 54989.175162371794, 70416.29583704098, 71760.0, 73515.26484735191, 72685.63657181681, 72833.0, 73275.63362183262, 73755.0, 75920.0, 64718.35281647217, 66125.0, 67209.32790672129, 67470.32529674738, 69636.6518167416, 9394.95302523483, 9952.601895924083, 9955.153811926068, 10025.0, 10201.0, 42096.3685544711, 42336.364954526325, 45637.543624564656, 45959.77020114878, 45970.540294597966, 59631.0, 59680.40319596748, 59821.70089149527, 60984.695076526106, 62132.68933655484, 12907.225566466042, 13074.673133171747, 13213.471461141447, 13585.116967397087, 13661.590152295446, 12760.74478510443, 12913.94186538046, 13496.190228586316, 14191.0, 14307.141571505743, 13778.379972901444, 13850.861491384958, 13978.301084945915, 14152.575422737335, 14678.192699401636, 12975.0, 13349.199048057148, 13378.197308161542, 13851.37668804886, 13937.58187254384, 13060.673483162616, 13391.330433478483, 13607.86392136066, 13650.112742671694, 13679.589612311647, 9739.41563506192, 9892.604295828087, 9905.405675659484, 10186.643467478603, 10301.381917084998, 10607.575696972342, 10649.520771565143, 10656.946715266375, 10799.298045627009, 10823.891761082288], "value": 7194.854044997893, "unit": "score"}], "name": "dromaeo_css", "value": 7345.8704124523965, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 110.0, 109.0, 111.0, 112.0, 111.0, 110.0, 110.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 116.0, 117.0, 150.0, 124.0, 125.0, 121.0, 119.0, 150.0, 118.0], "value": 128.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 161.0, 159.0, 161.0, 161.0, 161.0, 159.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 110.0, 75.0, 75.0, 81.0, 75.0, 97.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 109.0, 83.0, 82.0, 82.0, 99.0, 81.0, 83.0, 115.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 118.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 147.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 85.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 53.0, 51.0, 52.0, 53.0, 52.0, 51.0, 52.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 62.0, 62.0, 60.0, 61.0, 61.0, 60.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 75.0, 75.0, 74.0, 80.0, 80.0, 74.0, 75.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 127.0, 121.0, 121.0, 136.0, 122.0, 121.0, 121.0, 155.0, 122.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 162.0, 155.0, 154.0, 154.0, 156.0, 157.0, 156.0, 155.0, 155.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 62.0, 62.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1451.6000000000001, "alertThreshold": 2.0}]} 07:44:27 INFO - Return code: 0 07:44:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:44:27 INFO - # TBPL SUCCESS # 07:44:27 INFO - Running post-action listener: _resource_record_post_action 07:44:27 INFO - [mozharness: 2017-02-14 15:44:27.584948Z] Finished run-tests step (success) 07:44:27 INFO - Running post-run listener: _resource_record_post_run 07:44:27 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 614400; Write bytes: 322019328; Read time: 764; Write time: 179172 07:44:27 INFO - TinderboxPrint: CPU usage
13.0% 07:44:27 INFO - TinderboxPrint: I/O read bytes / time
614,400 / 764 07:44:27 INFO - TinderboxPrint: I/O write bytes / time
322,019,328 / 179,172 07:44:27 INFO - TinderboxPrint: CPU idle
8,254.9 (87.0%) 07:44:27 INFO - TinderboxPrint: CPU user
1,186.5 (12.5%) 07:44:27 INFO - TinderboxPrint: Swap in / out
0 / 0 07:44:27 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 4096; Write bytes: 101068800; Read time: 160; Write time: 69772 07:44:27 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 610304; Write bytes: 220950528; Read time: 604; Write time: 109400 07:44:28 INFO - Running post-run listener: _upload_blobber_files 07:44:28 INFO - Blob upload gear active. 07:44:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:44:28 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 07:44:28 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'] 07:44:28 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 07:44:28 INFO - (blobuploader) - INFO - Open directory for files ... 07:44:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:44:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:44:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:44:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:44:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:44:29 INFO - (blobuploader) - INFO - Done attempting. 07:44:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:44:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:44:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:44:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:44:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:44:30 INFO - (blobuploader) - INFO - Done attempting. 07:44:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:44:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:44:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:44:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:44:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:44:33 INFO - (blobuploader) - INFO - Done attempting. 07:44:33 INFO - (blobuploader) - INFO - Iteration through files over. 07:44:33 INFO - Return code: 0 07:44:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:44:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:44:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c9b026f01f20c0a7b7df3d79143e92ea7f80e66d7f0f1fab0111e6d0f61cbdc13f314d26c36728377299047f86f01685bb1edbe4072da826cfeed785c62874a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0ae1029bae75fbdb26381f577e62a9fbb58fd53904fc71139260f34bf33bc4bf4d14fe00a906730dc5987ce067f3b189fa4a748aa499be254ae5f7886004b171", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/777c992ad56385f2e22348b54afbc5fcda1afa8c13bd07242c3fb04767640ba80cbed81423c177d5a012bfcb9fc8308b57408bb84453e2d9a3528c00b48c0541"} 07:44:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:44:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:44:33 INFO - Contents: 07:44:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c9b026f01f20c0a7b7df3d79143e92ea7f80e66d7f0f1fab0111e6d0f61cbdc13f314d26c36728377299047f86f01685bb1edbe4072da826cfeed785c62874a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0ae1029bae75fbdb26381f577e62a9fbb58fd53904fc71139260f34bf33bc4bf4d14fe00a906730dc5987ce067f3b189fa4a748aa499be254ae5f7886004b171", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/777c992ad56385f2e22348b54afbc5fcda1afa8c13bd07242c3fb04767640ba80cbed81423c177d5a012bfcb9fc8308b57408bb84453e2d9a3528c00b48c0541"} 07:44:33 INFO - Running post-run listener: copy_logs_to_upload_dir 07:44:33 INFO - Copying logs to upload dir... 07:44:33 INFO - mkdir: /builds/slave/test/build/upload/logs 07:44:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.061668 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-14 07:44:33.590457) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 07:44:33.598501) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178 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/c9b026f01f20c0a7b7df3d79143e92ea7f80e66d7f0f1fab0111e6d0f61cbdc13f314d26c36728377299047f86f01685bb1edbe4072da826cfeed785c62874a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0ae1029bae75fbdb26381f577e62a9fbb58fd53904fc71139260f34bf33bc4bf4d14fe00a906730dc5987ce067f3b189fa4a748aa499be254ae5f7886004b171", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/777c992ad56385f2e22348b54afbc5fcda1afa8c13bd07242c3fb04767640ba80cbed81423c177d5a012bfcb9fc8308b57408bb84453e2d9a3528c00b48c0541"} build_url:https://queue.taskcluster.net/v1/task/CSWSCYxgR0WnOY1rvGYegQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011194 build_url: 'https://queue.taskcluster.net/v1/task/CSWSCYxgR0WnOY1rvGYegQ/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/c9b026f01f20c0a7b7df3d79143e92ea7f80e66d7f0f1fab0111e6d0f61cbdc13f314d26c36728377299047f86f01685bb1edbe4072da826cfeed785c62874a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0ae1029bae75fbdb26381f577e62a9fbb58fd53904fc71139260f34bf33bc4bf4d14fe00a906730dc5987ce067f3b189fa4a748aa499be254ae5f7886004b171", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/777c992ad56385f2e22348b54afbc5fcda1afa8c13bd07242c3fb04767640ba80cbed81423c177d5a012bfcb9fc8308b57408bb84453e2d9a3528c00b48c0541"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 07:44:33.625820) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 07:44:33.626214) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1487085218.727369-994373178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 07:44:33.675881) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 07:44:33.679224) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 07:44:33.679533) ========= ========= Total master_lag: 0.20 =========