builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-027 starttime: 1478645954.7 results: success (0) buildid: 20161108133523 builduid: 276da1f8087b4987b1e2bc9bd479cabd revision: 680094d957919bd757685e3de5fe244a5e038658 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 14:59:14.705281) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 14:59:14.705785) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 14:59:14.706087) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 14:59:14.726329) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 14:59:14.726628) ========= 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=1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-08 14:59:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 101M=0s 2016-11-08 14:59:15 (101 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.074932 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 14:59:15.002718) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 14:59:15.003039) ========= 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=1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020612 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 14:59:15.039206) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 14:59:15.039531) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 680094d957919bd757685e3de5fe244a5e038658 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 680094d957919bd757685e3de5fe244a5e038658 --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=1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-08 14:59:15,387 truncating revision to first 12 chars 2016-11-08 14:59:15,387 Setting DEBUG logging. 2016-11-08 14:59:15,387 attempt 1/10 2016-11-08 14:59:15,387 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/680094d95791?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-08 14:59:15,760 unpacking tar archive at: mozilla-central-680094d95791/testing/mozharness/ program finished with exit code 0 elapsedTime=0.686141 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 14:59:15.738742) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 14:59:15.739021) ========= script_repo_revision: 680094d957919bd757685e3de5fe244a5e038658 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 14:59:15.739415) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 14:59:15.739724) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 14:59:15.760628) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-11-08 14:59:15.761033) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:59:16 INFO - MultiFileLogger online at 20161108 14:59:16 in /builds/slave/test 14:59:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 14:59:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:59:16 INFO - {'append_to_log': False, 14:59:16 INFO - 'base_work_dir': '/builds/slave/test', 14:59:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:59:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:59:16 INFO - 'branch': 'Firefox-Non-PGO', 14:59:16 INFO - 'buildbot_json_path': 'buildprops.json', 14:59:16 INFO - 'config_files': ('talos/linux_config.py',), 14:59:16 INFO - 'default_actions': ('clobber', 14:59:16 INFO - 'read-buildbot-config', 14:59:16 INFO - 'download-and-extract', 14:59:16 INFO - 'populate-webroot', 14:59:16 INFO - 'create-virtualenv', 14:59:16 INFO - 'install', 14:59:16 INFO - 'run-tests'), 14:59:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:59:16 INFO - 'download_minidump_stackwalk': True, 14:59:16 INFO - 'download_symbols': 'ondemand', 14:59:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:59:16 INFO - 'tooltool.py': '/tools/tooltool.py', 14:59:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:59:16 INFO - '/tools/misc-python/virtualenv.py')}, 14:59:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:59:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:59:16 INFO - 'installer_path': 'installer.exe', 14:59:16 INFO - 'log_level': 'info', 14:59:16 INFO - 'log_name': 'talos', 14:59:16 INFO - 'log_to_console': True, 14:59:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:59:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:59:16 INFO - 'opt_config_files': (), 14:59:16 INFO - 'pip_index': False, 14:59:16 INFO - 'sps_profile': False, 14:59:16 INFO - 'sps_profile_interval': 0, 14:59:16 INFO - 'suite': 'dromaeojs', 14:59:16 INFO - 'system_bits': '32', 14:59:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:59:16 INFO - 'title': 'talos-linux64-ix-027', 14:59:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:59:16 INFO - 'use_talos_json': True, 14:59:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:59:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:59:16 INFO - 'work_dir': 'build'} 14:59:16 INFO - [mozharness: 2016-11-08 22:59:16.206097Z] Running clobber step. 14:59:16 INFO - Running pre-action listener: _resource_record_pre_action 14:59:16 INFO - Running main action method: clobber 14:59:16 INFO - rmtree: /builds/slave/test/build 14:59:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:59:16 INFO - Running post-action listener: _resource_record_post_action 14:59:16 INFO - [mozharness: 2016-11-08 22:59:16.659175Z] Finished clobber step (success) 14:59:16 INFO - [mozharness: 2016-11-08 22:59:16.659275Z] Running read-buildbot-config step. 14:59:16 INFO - Running pre-action listener: _resource_record_pre_action 14:59:16 INFO - Running main action method: read_buildbot_config 14:59:16 INFO - Using buildbot properties: 14:59:16 INFO - { 14:59:16 INFO - "project": "", 14:59:16 INFO - "product": "firefox", 14:59:16 INFO - "script_repo_revision": "production", 14:59:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 14:59:16 INFO - "repository": "", 14:59:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 14:59:16 INFO - "buildid": "20161108133523", 14:59:16 INFO - "pgo_build": "False", 14:59:16 INFO - "basedir": "/builds/slave/test", 14:59:16 INFO - "buildnumber": 290, 14:59:16 INFO - "slavename": "talos-linux64-ix-027", 14:59:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:59:16 INFO - "platform": "ubuntu64_hw", 14:59:16 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 14:59:16 INFO - "branch": "mozilla-central", 14:59:16 INFO - "repo_path": "mozilla-central", 14:59:16 INFO - "revision": "680094d957919bd757685e3de5fe244a5e038658", 14:59:16 INFO - "stage_platform": "linux64", 14:59:16 INFO - "builduid": "276da1f8087b4987b1e2bc9bd479cabd", 14:59:16 INFO - "slavebuilddir": "test" 14:59:16 INFO - } 14:59:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 14:59:16 INFO - Running post-action listener: _resource_record_post_action 14:59:16 INFO - [mozharness: 2016-11-08 22:59:16.661684Z] Finished read-buildbot-config step (success) 14:59:16 INFO - [mozharness: 2016-11-08 22:59:16.661769Z] Running download-and-extract step. 14:59:16 INFO - Running pre-action listener: _resource_record_pre_action 14:59:16 INFO - Running main action method: download_and_extract 14:59:16 INFO - mkdir: /builds/slave/test/build/tests 14:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:16 INFO - trying https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:59:16 INFO - Downloading https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:59:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:59:17 INFO - Downloaded 1361 bytes. 14:59:17 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:59:17 INFO - Using the following test package requirements: 14:59:17 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 14:59:17 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:59:17 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:59:17 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:17 INFO - u'jsshell-linux-x86_64.zip'], 14:59:17 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:59:17 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 14:59:17 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:59:17 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:59:17 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:59:17 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:59:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:59:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 14:59:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:59:17 INFO - Fetch https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:59:17 INFO - Http code: 200 14:59:17 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 14:59:17 INFO - x-amz-cf-id: 6XBmYK8raPgTCTFY-SoXvLI0Vap7Mp_TmTMxG2oJ3oIhhRLfu7s1Og== 14:59:17 INFO - x-amz-version-id: LrbZbzcXF6NnuHAMJbWomrOzJPa5o7Pv 14:59:18 INFO - Expected file size: 20358703 14:59:18 INFO - Obtained file size: 20358703 14:59:22 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:59:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 14:59:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:59:22 INFO - Fetch https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:59:22 INFO - Http code: 200 14:59:22 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 14:59:22 INFO - x-amz-cf-id: qActRXh6IsgaNyIGYCrqplqVi97kaZLKFoXqPhlQo6jkA8qzpNnnNw== 14:59:22 INFO - x-amz-version-id: LrbZbzcXF6NnuHAMJbWomrOzJPa5o7Pv 14:59:22 INFO - Expected file size: 20358703 14:59:22 INFO - Obtained file size: 20358703 14:59:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 14:59:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:59:27 INFO - Fetch https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 14:59:27 INFO - Http code: 200 14:59:27 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 14:59:27 INFO - x-amz-cf-id: gBS0FQC-vk4tkuw4pkAr4BKmlUuHKru2Y5vJYTWSqm1ftdoTjudfiA== 14:59:27 INFO - x-amz-version-id: yUFQVV9bLeA3lvdhK3TUPcAOqzeLW5Ad 14:59:28 INFO - Expected file size: 14409038 14:59:28 INFO - Obtained file size: 14409038 14:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:28 INFO - trying https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:59:28 INFO - Downloading https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:59:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:59:29 INFO - Downloaded 55918074 bytes. 14:59:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:59:29 INFO - mkdir: /builds/slave/test/properties 14:59:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:59:29 INFO - Writing to file /builds/slave/test/properties/build_url 14:59:29 INFO - Contents: 14:59:29 INFO - build_url:https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:59:30 INFO - Running post-action listener: _resource_record_post_action 14:59:30 INFO - Running post-action listener: set_extra_try_arguments 14:59:30 INFO - [mozharness: 2016-11-08 22:59:30.071906Z] Finished download-and-extract step (success) 14:59:30 INFO - [mozharness: 2016-11-08 22:59:30.072203Z] Running populate-webroot step. 14:59:30 INFO - Running pre-action listener: _resource_record_pre_action 14:59:30 INFO - Running main action method: populate_webroot 14:59:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:59:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:59:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:59:30 INFO - '--tppagecycles', 14:59:30 INFO - '7'], 14:59:30 INFO - 'tests': ['tsvgm']}}, 14:59:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:59:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:59:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:59:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:59:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:59:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:59:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:30 INFO - 'talos_options': ['--disable-e10s'], 14:59:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:59:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:59:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:30 INFO - 'talos_options': ['--disable-e10s'], 14:59:30 INFO - 'tests': ['damp', 'tps']}, 14:59:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:30 INFO - 'tests': ['damp', 'tps']}, 14:59:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:59:30 INFO - 'tests': ['dromaeo_dom']}, 14:59:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:59:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:59:30 INFO - 'tests': ['basic_compositor_video']}, 14:59:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:59:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:59:30 INFO - 'tests': ['a11yr', 14:59:30 INFO - 'ts_paint', 14:59:30 INFO - 'tpaint', 14:59:30 INFO - 'sessionrestore', 14:59:30 INFO - 'sessionrestore_no_auto_restore', 14:59:30 INFO - 'tabpaint']}, 14:59:30 INFO - 'other-e10s': {'tests': ['a11yr', 14:59:30 INFO - 'ts_paint', 14:59:30 INFO - 'tpaint', 14:59:30 INFO - 'sessionrestore', 14:59:30 INFO - 'sessionrestore_no_auto_restore', 14:59:30 INFO - 'tabpaint']}, 14:59:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:59:30 INFO - 'ts_paint', 14:59:30 INFO - 'tpaint', 14:59:30 INFO - 'sessionrestore', 14:59:30 INFO - 'sessionrestore_no_auto_restore', 14:59:30 INFO - 'tabpaint']}, 14:59:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:59:30 INFO - 'ts_paint', 14:59:30 INFO - 'tpaint', 14:59:30 INFO - 'sessionrestore', 14:59:30 INFO - 'sessionrestore_no_auto_restore', 14:59:30 INFO - 'tabpaint']}, 14:59:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:59:30 INFO - 'tests': ['a11yr', 14:59:30 INFO - 'ts_paint', 14:59:30 INFO - 'tpaint', 14:59:30 INFO - 'sessionrestore', 14:59:30 INFO - 'sessionrestore_no_auto_restore', 14:59:30 INFO - 'tabpaint']}, 14:59:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:59:30 INFO - 'tests': ['a11yr', 14:59:30 INFO - 'ts_paint', 14:59:30 INFO - 'tpaint', 14:59:30 INFO - 'sessionrestore', 14:59:30 INFO - 'sessionrestore_no_auto_restore', 14:59:30 INFO - 'tabpaint']}, 14:59:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:59:30 INFO - 'tests': ['tsvgx', 14:59:30 INFO - 'tsvgr_opacity', 14:59:30 INFO - 'tart', 14:59:30 INFO - 'tscrollx', 14:59:30 INFO - 'cart']}, 14:59:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:59:30 INFO - 'tsvgr_opacity', 14:59:30 INFO - 'tart', 14:59:30 INFO - 'tscrollx', 14:59:30 INFO - 'cart']}, 14:59:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:30 INFO - 'talos_options': ['--disable-e10s'], 14:59:30 INFO - 'tests': ['tp5o']}, 14:59:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:30 INFO - 'tests': ['tp5o']}, 14:59:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:30 INFO - 'talos_options': ['--disable-e10s', 14:59:30 INFO - '--xperf_path', 14:59:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:59:30 INFO - 'tests': ['tp5n']}, 14:59:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:30 INFO - 'talos_options': ['--xperf_path', 14:59:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:59:30 INFO - 'tests': ['tp5n']}}, 14:59:30 INFO - 'talos.zip': {'path': '', 14:59:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:59:30 INFO - Running post-action listener: _resource_record_post_action 14:59:30 INFO - [mozharness: 2016-11-08 22:59:30.095535Z] Finished populate-webroot step (success) 14:59:30 INFO - [mozharness: 2016-11-08 22:59:30.095627Z] Running create-virtualenv step. 14:59:30 INFO - Running pre-action listener: _resource_record_pre_action 14:59:30 INFO - Running main action method: create_virtualenv 14:59:30 INFO - Creating virtualenv /builds/slave/test/build/venv 14:59:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:59:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:59:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:59:30 INFO - Using real prefix '/usr' 14:59:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:59:30 INFO - Installing distribute.............................................................................................................................................................................................done. 14:59:32 INFO - Installing pip.................done. 14:59:32 INFO - Return code: 0 14:59:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:59:32 INFO - Reading from file tmpfile_stdout 14:59:32 INFO - Output received: 14:59:32 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) 14:59:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:59:32 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')]} 14:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:32 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')]} 14:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:32 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 0x7f8d26fdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294cf60>, '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 0x294dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294e1d0>, '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': '1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051', '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 14:59:32 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 14:59:32 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 14:59:32 INFO - Using env: {'DISPLAY': ':0', 14:59:32 INFO - 'HOME': '/home/cltbld', 14:59:32 INFO - 'LANG': 'en_US.UTF-8', 14:59:32 INFO - 'LANGUAGE': 'en_US:en', 14:59:32 INFO - 'LOGNAME': 'cltbld', 14:59:32 INFO - 'MAIL': '/var/mail/cltbld', 14:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:32 INFO - 'MOZ_NO_REMOTE': '1', 14:59:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:32 INFO - 'NO_EM_RESTART': '1', 14:59:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:32 INFO - 'PWD': '/builds/slave/test', 14:59:32 INFO - 'SHELL': '/bin/bash', 14:59:32 INFO - 'SHLVL': '1', 14:59:32 INFO - 'TERM': 'linux', 14:59:32 INFO - 'TMOUT': '86400', 14:59:32 INFO - 'USER': 'cltbld', 14:59:32 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051', 14:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:32 INFO - '_': '/tools/buildbot/bin/python'} 14:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:59:33 INFO - Cleaning up... 14:59:33 INFO - Return code: 0 14:59:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d26fdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294cf60>, '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 0x294dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294e1d0>, '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': '1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051', '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 14:59:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:59:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:59:33 INFO - Using env: {'DISPLAY': ':0', 14:59:33 INFO - 'HOME': '/home/cltbld', 14:59:33 INFO - 'LANG': 'en_US.UTF-8', 14:59:33 INFO - 'LANGUAGE': 'en_US:en', 14:59:33 INFO - 'LOGNAME': 'cltbld', 14:59:33 INFO - 'MAIL': '/var/mail/cltbld', 14:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:33 INFO - 'MOZ_NO_REMOTE': '1', 14:59:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:33 INFO - 'NO_EM_RESTART': '1', 14:59:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:33 INFO - 'PWD': '/builds/slave/test', 14:59:33 INFO - 'SHELL': '/bin/bash', 14:59:33 INFO - 'SHLVL': '1', 14:59:33 INFO - 'TERM': 'linux', 14:59:33 INFO - 'TMOUT': '86400', 14:59:33 INFO - 'USER': 'cltbld', 14:59:33 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051', 14:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:33 INFO - '_': '/tools/buildbot/bin/python'} 14:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:33 INFO - Downloading/unpacking psutil>=3.1.1 14:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:59:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:59:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:59:35 INFO - Installing collected packages: psutil 14:59:35 INFO - Running setup.py install for psutil 14:59:35 INFO - building 'psutil._psutil_linux' extension 14:59:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:59:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:59:35 INFO - building 'psutil._psutil_posix' extension 14:59:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:59:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:59:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:59:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:59:35 INFO - Successfully installed psutil 14:59:35 INFO - Cleaning up... 14:59:35 INFO - Return code: 0 14:59:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:59:35 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')]} 14:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:35 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')]} 14:59:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:35 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 0x7f8d26fdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294cf60>, '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 0x294dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294e1d0>, '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': '1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051', '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 14:59:35 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 14:59:35 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 14:59:35 INFO - Using env: {'DISPLAY': ':0', 14:59:35 INFO - 'HOME': '/home/cltbld', 14:59:35 INFO - 'LANG': 'en_US.UTF-8', 14:59:35 INFO - 'LANGUAGE': 'en_US:en', 14:59:35 INFO - 'LOGNAME': 'cltbld', 14:59:35 INFO - 'MAIL': '/var/mail/cltbld', 14:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:35 INFO - 'MOZ_NO_REMOTE': '1', 14:59:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:35 INFO - 'NO_EM_RESTART': '1', 14:59:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:35 INFO - 'PWD': '/builds/slave/test', 14:59:35 INFO - 'SHELL': '/bin/bash', 14:59:35 INFO - 'SHLVL': '1', 14:59:35 INFO - 'TERM': 'linux', 14:59:35 INFO - 'TMOUT': '86400', 14:59:35 INFO - 'USER': 'cltbld', 14:59:35 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051', 14:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:35 INFO - '_': '/tools/buildbot/bin/python'} 14:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:59: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 14:59: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 14:59: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 14:59: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 14:59: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 14:59: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 14:59:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:59:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:59:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:59:38 INFO - Installing collected packages: mozsystemmonitor 14:59:38 INFO - Running setup.py install for mozsystemmonitor 14:59:38 INFO - Successfully installed mozsystemmonitor 14:59:38 INFO - Cleaning up... 14:59:38 INFO - Return code: 0 14:59:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:59: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')]} 14:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59: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')]} 14:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d26fdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294cf60>, '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 0x294dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294e1d0>, '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': '1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051', '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 14:59:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:59:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:59:38 INFO - Using env: {'DISPLAY': ':0', 14:59:38 INFO - 'HOME': '/home/cltbld', 14:59:38 INFO - 'LANG': 'en_US.UTF-8', 14:59:38 INFO - 'LANGUAGE': 'en_US:en', 14:59:38 INFO - 'LOGNAME': 'cltbld', 14:59:38 INFO - 'MAIL': '/var/mail/cltbld', 14:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:38 INFO - 'MOZ_NO_REMOTE': '1', 14:59:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:38 INFO - 'NO_EM_RESTART': '1', 14:59:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:38 INFO - 'PWD': '/builds/slave/test', 14:59:38 INFO - 'SHELL': '/bin/bash', 14:59:38 INFO - 'SHLVL': '1', 14:59:38 INFO - 'TERM': 'linux', 14:59:38 INFO - 'TMOUT': '86400', 14:59:38 INFO - 'USER': 'cltbld', 14:59:38 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051', 14:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:38 INFO - '_': '/tools/buildbot/bin/python'} 14:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:38 INFO - Downloading/unpacking jsonschema==2.5.1 14:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:59:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:40 INFO - Downloading functools32-3.2.3-2.tar.gz 14:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:59:40 INFO - warning: no files found matching '*.txt' 14:59:40 INFO - no previously-included directories found matching 'build' 14:59:40 INFO - no previously-included directories found matching 'dist' 14:59:40 INFO - no previously-included directories found matching '.git*' 14:59:40 INFO - Installing collected packages: jsonschema, functools32 14:59:40 INFO - Running setup.py install for functools32 14:59:40 INFO - warning: no files found matching '*.txt' 14:59:40 INFO - no previously-included directories found matching 'build' 14:59:40 INFO - no previously-included directories found matching 'dist' 14:59:40 INFO - no previously-included directories found matching '.git*' 14:59:40 INFO - Successfully installed jsonschema functools32 14:59:40 INFO - Cleaning up... 14:59:40 INFO - Return code: 0 14:59:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:59:40 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')]} 14:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:40 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')]} 14:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:40 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 0x7f8d26fdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294cf60>, '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 0x294dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294e1d0>, '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': '1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051', '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 14:59:40 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 14:59:40 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 14:59:40 INFO - Using env: {'DISPLAY': ':0', 14:59:40 INFO - 'HOME': '/home/cltbld', 14:59:40 INFO - 'LANG': 'en_US.UTF-8', 14:59:40 INFO - 'LANGUAGE': 'en_US:en', 14:59:40 INFO - 'LOGNAME': 'cltbld', 14:59:40 INFO - 'MAIL': '/var/mail/cltbld', 14:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:40 INFO - 'MOZ_NO_REMOTE': '1', 14:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:40 INFO - 'NO_EM_RESTART': '1', 14:59:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:40 INFO - 'PWD': '/builds/slave/test', 14:59:40 INFO - 'SHELL': '/bin/bash', 14:59:40 INFO - 'SHLVL': '1', 14:59:40 INFO - 'TERM': 'linux', 14:59:40 INFO - 'TMOUT': '86400', 14:59:40 INFO - 'USER': 'cltbld', 14:59:40 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051', 14:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:40 INFO - '_': '/tools/buildbot/bin/python'} 14:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:59:41 INFO - Cleaning up... 14:59:41 INFO - Return code: 0 14:59:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d26fdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294cf60>, '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 0x294dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294e1d0>, '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': '1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051', '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 14:59:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:59:41 INFO - Using env: {'DISPLAY': ':0', 14:59:41 INFO - 'HOME': '/home/cltbld', 14:59:41 INFO - 'LANG': 'en_US.UTF-8', 14:59:41 INFO - 'LANGUAGE': 'en_US:en', 14:59:41 INFO - 'LOGNAME': 'cltbld', 14:59:41 INFO - 'MAIL': '/var/mail/cltbld', 14:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:41 INFO - 'MOZ_NO_REMOTE': '1', 14:59:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:41 INFO - 'NO_EM_RESTART': '1', 14:59:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:41 INFO - 'PWD': '/builds/slave/test', 14:59:41 INFO - 'SHELL': '/bin/bash', 14:59:41 INFO - 'SHLVL': '1', 14:59:41 INFO - 'TERM': 'linux', 14:59:41 INFO - 'TMOUT': '86400', 14:59:41 INFO - 'USER': 'cltbld', 14:59:41 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051', 14:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:41 INFO - '_': '/tools/buildbot/bin/python'} 14:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:41 INFO - Downloading/unpacking blobuploader==1.2.4 14:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:43 INFO - Downloading blobuploader-1.2.4.tar.gz 14:59:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:59:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:59:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:43 INFO - Downloading docopt-0.6.1.tar.gz 14:59:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:59:44 INFO - Installing collected packages: blobuploader, requests, docopt 14:59:44 INFO - Running setup.py install for blobuploader 14:59:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:59:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:59:44 INFO - Running setup.py install for requests 14:59:44 INFO - Running setup.py install for docopt 14:59:44 INFO - Successfully installed blobuploader requests docopt 14:59:44 INFO - Cleaning up... 14:59:44 INFO - Return code: 0 14:59:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d26fdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294cf60>, '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 0x294dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294e1d0>, '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': '1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051', '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 14:59:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:59:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:59:44 INFO - Using env: {'DISPLAY': ':0', 14:59:44 INFO - 'HOME': '/home/cltbld', 14:59:44 INFO - 'LANG': 'en_US.UTF-8', 14:59:44 INFO - 'LANGUAGE': 'en_US:en', 14:59:44 INFO - 'LOGNAME': 'cltbld', 14:59:44 INFO - 'MAIL': '/var/mail/cltbld', 14:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:44 INFO - 'MOZ_NO_REMOTE': '1', 14:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:44 INFO - 'NO_EM_RESTART': '1', 14:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:44 INFO - 'PWD': '/builds/slave/test', 14:59:44 INFO - 'SHELL': '/bin/bash', 14:59:44 INFO - 'SHLVL': '1', 14:59:44 INFO - 'TERM': 'linux', 14:59:44 INFO - 'TMOUT': '86400', 14:59:44 INFO - 'USER': 'cltbld', 14:59:44 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051', 14:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:44 INFO - '_': '/tools/buildbot/bin/python'} 14:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:59:44 INFO - Running setup.py (path:/tmp/pip-89UZEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:59:44 INFO - Running setup.py (path:/tmp/pip-6Z0CdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:59:44 INFO - Running setup.py (path:/tmp/pip-mopum1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:59:45 INFO - Running setup.py (path:/tmp/pip-3IHHr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:59:45 INFO - Running setup.py (path:/tmp/pip-lhev2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:59:45 INFO - Running setup.py (path:/tmp/pip-eq6yvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:59:45 INFO - Running setup.py (path:/tmp/pip-tNdjWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:59:45 INFO - Running setup.py (path:/tmp/pip-0CbuwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:59:45 INFO - Running setup.py (path:/tmp/pip-RM2Z56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:59:45 INFO - Running setup.py (path:/tmp/pip-8vVL6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:59:45 INFO - Running setup.py (path:/tmp/pip-EnMXtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:59:45 INFO - Running setup.py (path:/tmp/pip-6H2Bef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:59:45 INFO - Running setup.py (path:/tmp/pip-HcPz1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:59:45 INFO - Running setup.py (path:/tmp/pip-T7ACHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:45 INFO - Running setup.py (path:/tmp/pip-1RN7ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:59:45 INFO - Running setup.py (path:/tmp/pip-Bb8Qyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:59:45 INFO - Running setup.py (path:/tmp/pip-LoZmci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:59:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:59:46 INFO - Running setup.py install for manifestparser 14:59:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:59:46 INFO - Running setup.py install for mozcrash 14:59:46 INFO - Running setup.py install for mozdebug 14:59:46 INFO - Running setup.py install for mozdevice 14:59:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:59:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:59:46 INFO - Running setup.py install for mozfile 14:59:46 INFO - Running setup.py install for mozhttpd 14:59:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:59:46 INFO - Running setup.py install for mozinfo 14:59:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:59:46 INFO - Running setup.py install for mozInstall 14:59:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:59:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:59:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:59:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:59:46 INFO - Running setup.py install for mozleak 14:59:46 INFO - Running setup.py install for mozlog 14:59:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:59:47 INFO - Running setup.py install for moznetwork 14:59:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:59:47 INFO - Running setup.py install for mozprocess 14:59:47 INFO - Running setup.py install for mozprofile 14:59:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:59:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:59:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:59:47 INFO - Running setup.py install for mozrunner 14:59:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:59:47 INFO - Running setup.py install for mozscreenshot 14:59:47 INFO - Running setup.py install for moztest 14:59:47 INFO - Running setup.py install for mozversion 14:59:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:59:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:59:47 INFO - Cleaning up... 14:59:47 INFO - Return code: 0 14:59:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59:47 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')]} 14:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:47 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')]} 14:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:47 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 0x7f8d26fdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294cf60>, '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 0x294dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294e1d0>, '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': '1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051', '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 14:59:47 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 14:59:47 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 14:59:47 INFO - Using env: {'DISPLAY': ':0', 14:59:47 INFO - 'HOME': '/home/cltbld', 14:59:47 INFO - 'LANG': 'en_US.UTF-8', 14:59:47 INFO - 'LANGUAGE': 'en_US:en', 14:59:47 INFO - 'LOGNAME': 'cltbld', 14:59:47 INFO - 'MAIL': '/var/mail/cltbld', 14:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:47 INFO - 'MOZ_NO_REMOTE': '1', 14:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:47 INFO - 'NO_EM_RESTART': '1', 14:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:47 INFO - 'PWD': '/builds/slave/test', 14:59:47 INFO - 'SHELL': '/bin/bash', 14:59:47 INFO - 'SHLVL': '1', 14:59:47 INFO - 'TERM': 'linux', 14:59:47 INFO - 'TMOUT': '86400', 14:59:47 INFO - 'USER': 'cltbld', 14:59:47 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051', 14:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:47 INFO - '_': '/tools/buildbot/bin/python'} 14:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:59:48 INFO - Running setup.py (path:/tmp/pip-MN3Las-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:59:48 INFO - Running setup.py (path:/tmp/pip-Skkwq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:59:48 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)) 14:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:59:48 INFO - Running setup.py (path:/tmp/pip-3IHwVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:59:48 INFO - Running setup.py (path:/tmp/pip-eTV3RD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:59:48 INFO - Running setup.py (path:/tmp/pip-8QdJml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:59:48 INFO - Running setup.py (path:/tmp/pip-4jwwRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:59:48 INFO - Running setup.py (path:/tmp/pip-Rxe_XG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:59:48 INFO - Running setup.py (path:/tmp/pip-MUIWrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:59:48 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)) 14:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:59:48 INFO - Running setup.py (path:/tmp/pip-w4OkgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:59:48 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)) 14:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:59:48 INFO - Running setup.py (path:/tmp/pip-VIoCgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:59:48 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)) 14:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:59:48 INFO - Running setup.py (path:/tmp/pip-PODhp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:59:48 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)) 14:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:59:48 INFO - Running setup.py (path:/tmp/pip-BmzVYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:59:48 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)) 14:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:59:48 INFO - Running setup.py (path:/tmp/pip-j3W00e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:59:49 INFO - Running setup.py (path:/tmp/pip-M43dtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:59:49 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)) 14:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:49 INFO - Running setup.py (path:/tmp/pip-_m0Lgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:59:49 INFO - Running setup.py (path:/tmp/pip-kq00pO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:59:49 INFO - Running setup.py (path:/tmp/pip-_likht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:59:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:51 INFO - Downloading blessings-1.6.tar.gz 14:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:59:51 INFO - Installing collected packages: blessings 14:59:51 INFO - Running setup.py install for blessings 14:59:51 INFO - Successfully installed blessings 14:59:51 INFO - Cleaning up... 14:59:51 INFO - Return code: 0 14:59:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:59:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:59:51 INFO - Reading from file tmpfile_stdout 14:59:51 INFO - Current package versions: 14:59:51 INFO - argparse == 1.2.1 14:59:51 INFO - blessings == 1.6 14:59:51 INFO - blobuploader == 1.2.4 14:59:51 INFO - docopt == 0.6.1 14:59:51 INFO - functools32 == 3.2.3-2 14:59:51 INFO - jsonschema == 2.5.1 14:59:51 INFO - manifestparser == 1.1 14:59:51 INFO - mozInstall == 1.12 14:59:51 INFO - mozcrash == 1.0 14:59:51 INFO - mozdebug == 0.1 14:59:51 INFO - mozdevice == 0.48 14:59:51 INFO - mozfile == 1.2 14:59:51 INFO - mozhttpd == 0.7 14:59:51 INFO - mozinfo == 0.9 14:59:51 INFO - mozleak == 0.1 14:59:51 INFO - mozlog == 3.4 14:59:51 INFO - moznetwork == 0.27 14:59:51 INFO - mozprocess == 0.23 14:59:51 INFO - mozprofile == 0.28 14:59:51 INFO - mozrunner == 6.13 14:59:51 INFO - mozscreenshot == 0.1 14:59:51 INFO - mozsystemmonitor == 0.3 14:59:51 INFO - moztest == 0.7 14:59:51 INFO - mozversion == 1.4 14:59:51 INFO - psutil == 3.1.1 14:59:51 INFO - requests == 1.2.3 14:59:51 INFO - wsgiref == 0.1.2 14:59:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:51 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 0x7f8d26fdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294cf60>, '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 0x294dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294e1d0>, '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': '1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051', '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 14:59:51 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 14:59:51 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 14:59:51 INFO - Using env: {'DISPLAY': ':0', 14:59:51 INFO - 'HOME': '/home/cltbld', 14:59:51 INFO - 'LANG': 'en_US.UTF-8', 14:59:51 INFO - 'LANGUAGE': 'en_US:en', 14:59:51 INFO - 'LOGNAME': 'cltbld', 14:59:51 INFO - 'MAIL': '/var/mail/cltbld', 14:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:51 INFO - 'MOZ_NO_REMOTE': '1', 14:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:51 INFO - 'NO_EM_RESTART': '1', 14:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:51 INFO - 'PWD': '/builds/slave/test', 14:59:51 INFO - 'SHELL': '/bin/bash', 14:59:51 INFO - 'SHLVL': '1', 14:59:51 INFO - 'TERM': 'linux', 14:59:51 INFO - 'TMOUT': '86400', 14:59:51 INFO - 'USER': 'cltbld', 14:59:51 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051', 14:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:51 INFO - '_': '/tools/buildbot/bin/python'} 14:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:51 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)) 14:59:51 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)) 14:59:51 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)) 14:59:51 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)) 14:59:51 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)) 14:59:51 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)) 14:59:51 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)) 14:59:51 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)) 14:59:51 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)) 14:59:51 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)) 14:59:51 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)) 14:59:51 INFO - Cleaning up... 14:59:51 INFO - Return code: 0 14:59:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:51 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 0x7f8d26fdef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294cf60>, '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 0x294dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294e1d0>, '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': '1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051', '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 14:59:51 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 14:59:51 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 14:59:51 INFO - Using env: {'DISPLAY': ':0', 14:59:51 INFO - 'HOME': '/home/cltbld', 14:59:51 INFO - 'LANG': 'en_US.UTF-8', 14:59:51 INFO - 'LANGUAGE': 'en_US:en', 14:59:51 INFO - 'LOGNAME': 'cltbld', 14:59:51 INFO - 'MAIL': '/var/mail/cltbld', 14:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:51 INFO - 'MOZ_NO_REMOTE': '1', 14:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:51 INFO - 'NO_EM_RESTART': '1', 14:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:51 INFO - 'PWD': '/builds/slave/test', 14:59:51 INFO - 'SHELL': '/bin/bash', 14:59:51 INFO - 'SHLVL': '1', 14:59:51 INFO - 'TERM': 'linux', 14:59:51 INFO - 'TMOUT': '86400', 14:59:51 INFO - 'USER': 'cltbld', 14:59:51 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051', 14:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:51 INFO - '_': '/tools/buildbot/bin/python'} 14:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:59:52 INFO - Cleaning up... 14:59:52 INFO - Return code: 0 14:59:52 INFO - Running post-action listener: _resource_record_post_action 14:59:52 INFO - Running post-action listener: _start_resource_monitoring 14:59:52 INFO - Starting resource monitoring. 14:59:52 INFO - [mozharness: 2016-11-08 22:59:52.184078Z] Finished create-virtualenv step (success) 14:59:52 INFO - [mozharness: 2016-11-08 22:59:52.184585Z] Running install step. 14:59:52 INFO - Running pre-action listener: _resource_record_pre_action 14:59:52 INFO - Running main action method: install 14:59:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:59:52 INFO - Reading from file tmpfile_stdout 14:59:52 INFO - Detecting whether we're running mozinstall >=1.0... 14:59:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:59:52 INFO - Reading from file tmpfile_stdout 14:59:52 INFO - Output received: 14:59:52 INFO - Usage: mozinstall [options] installer 14:59:52 INFO - Options: 14:59:52 INFO - -h, --help show this help message and exit 14:59:52 INFO - -d DEST, --destination=DEST 14:59:52 INFO - Directory to install application into. [default: 14:59:52 INFO - "/builds/slave/test"] 14:59:52 INFO - --app=APP Application being installed. [default: firefox] 14:59:52 INFO - mkdir: /builds/slave/test/build/application 14:59:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:00:08 INFO - Reading from file tmpfile_stdout 15:00:08 INFO - Output received: 15:00:08 INFO - /builds/slave/test/build/application/firefox/firefox 15:00:08 INFO - Running post-action listener: _resource_record_post_action 15:00:08 INFO - [mozharness: 2016-11-08 23:00:08.587402Z] Finished install step (success) 15:00:08 INFO - [mozharness: 2016-11-08 23:00:08.587644Z] Running run-tests step. 15:00:08 INFO - Running pre-action listener: _resource_record_pre_action 15:00:08 INFO - Running main action method: run_tests 15:00:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:00:08 INFO - Python 2.7.3 15:00:08 INFO - Return code: 0 15:00:08 INFO - grabbing minidump binary from tooltool 15:00:08 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')]} 15:00:08 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 0x294cf60>, '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 0x294dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294e1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:00:08 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 15:00:08 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 15:00:08 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 15:00:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:00:08 INFO - Return code: 0 15:00:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:00:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:00:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:00:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:00:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:00:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 15:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 15:00:08 INFO - Using env: {'DISPLAY': ':0', 15:00:08 INFO - 'HOME': '/home/cltbld', 15:00:08 INFO - 'LANG': 'en_US.UTF-8', 15:00:08 INFO - 'LANGUAGE': 'en_US:en', 15:00:08 INFO - 'LOGNAME': 'cltbld', 15:00:08 INFO - 'MAIL': '/var/mail/cltbld', 15:00:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:00:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:08 INFO - 'MOZ_NO_REMOTE': '1', 15:00:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:08 INFO - 'NO_EM_RESTART': '1', 15:00:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:08 INFO - 'PWD': '/builds/slave/test', 15:00:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:00:08 INFO - 'SHELL': '/bin/bash', 15:00:08 INFO - 'SHLVL': '1', 15:00:08 INFO - 'TERM': 'linux', 15:00:08 INFO - 'TMOUT': '86400', 15:00:08 INFO - 'USER': 'cltbld', 15:00:08 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051', 15:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:08 INFO - '_': '/tools/buildbot/bin/python'} 15:00:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 15:00:08 INFO - mozversion application_buildid: 20161108133523 15:00:08 INFO - mozversion application_changeset: 680094d957919bd757685e3de5fe244a5e038658 15:00:08 INFO - mozversion application_display_name: Nightly 15:00:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:00:08 INFO - mozversion application_name: Firefox 15:00:08 INFO - mozversion application_remotingname: firefox 15:00:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:00:08 INFO - mozversion application_vendor: Mozilla 15:00:08 INFO - mozversion application_version: 52.0a1 15:00:08 INFO - mozversion platform_buildid: 20161108133523 15:00:08 INFO - mozversion platform_changeset: 680094d957919bd757685e3de5fe244a5e038658 15:00:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:00:08 INFO - mozversion platform_version: 52.0a1 15:00:08 INFO - using testdate: 1478646008 15:00:08 INFO - actual date: 1478646008 15:00:08 INFO - starting webserver on 'localhost:51280' 15:00:08 INFO - SUITE-START | Running 2 tests 15:00:08 INFO - TEST-START | dromaeo_css 15:00:08 INFO - operating with platform_type : linux_ 15:00:08 INFO - Initialising browser for dromaeo_css test... 15:00:08 INFO - TEST-INFO | started process 31492 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVO79KQ/profile http://localhost:51280/getInfo.html) 15:00:13 INFO - PROCESS | 31492 | __metrics Screen width/height:1600/1200 15:00:13 INFO - PROCESS | 31492 | colorDepth:24 15:00:13 INFO - PROCESS | 31492 | Browser inner width/height: 1024/697 15:00:13 INFO - PROCESS | 31492 | __metrics 15:00:13 INFO - PROCESS | 31492 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:00:13 INFO - PROCESS | 31492 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:00:14 INFO - PROCESS | 31492 | console.error: PushService: 15:00:14 INFO - PROCESS | 31492 | stateChangeProcessEnqueue: Error transitioning state 15:00:14 INFO - PROCESS | 31492 | UnknownError 15:00:15 INFO - TEST-INFO | 31492: exit 0 15:00:15 INFO - Browser initialized. 15:00:15 INFO - Running cycle 1/1 for dromaeo_css test... 15:00:15 INFO - TEST-INFO | started process 31575 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVO79KQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:00:27 INFO - PROCESS | 31575 | RSS: Main: 174432256 15:00:27 INFO - PROCESS | 31575 | 15:01:19 INFO - PROCESS | 31575 | 1478646079238 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:03:32 INFO - PROCESS | 31575 | Cycle 1(1): loaded http://localhost:51280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51280/tests/dromaeo/cssquery-ext.html) 15:03:33 INFO - PROCESS | 31575 | RSS: Main: 314994688 15:03:33 INFO - PROCESS | 31575 | 15:06:36 INFO - PROCESS | 31575 | Cycle 1(1): loaded http://localhost:51280/tests/dromaeo/cssquery-ext.html (next: http://localhost:51280/tests/dromaeo/cssquery-jquery.html) 15:06:37 INFO - PROCESS | 31575 | RSS: Main: 278577152 15:06:37 INFO - PROCESS | 31575 | 15:09:39 INFO - PROCESS | 31575 | Cycle 1(1): loaded http://localhost:51280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51280/tests/dromaeo/cssquery-mootools.html) 15:09:39 INFO - PROCESS | 31575 | RSS: Main: 222670848 15:09:39 INFO - PROCESS | 31575 | 15:12:42 INFO - PROCESS | 31575 | Cycle 1(1): loaded http://localhost:51280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51280/tests/dromaeo/cssquery-prototype.html) 15:12:42 INFO - PROCESS | 31575 | RSS: Main: 220385280 15:12:42 INFO - PROCESS | 31575 | 15:15:46 INFO - PROCESS | 31575 | Cycle 1(1): loaded http://localhost:51280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51280/tests/dromaeo/cssquery-yui.html) 15:15:46 INFO - PROCESS | 31575 | RSS: Main: 219136000 15:15:46 INFO - PROCESS | 31575 | 15:18:49 INFO - PROCESS | 31575 | Cycle 1(1): loaded http://localhost:51280/tests/dromaeo/cssquery-yui.html (next: http://localhost:51280/tests/dromaeo/cssquery-dojo.html) 15:18:49 INFO - PROCESS | 31575 | RSS: Main: 313950208 15:18:49 INFO - PROCESS | 31575 | 15:18:49 INFO - PROCESS | 31575 | __start_tp_report 15:18:49 INFO - PROCESS | 31575 | _x_x_mozilla_page_load 15:18:49 INFO - PROCESS | 31575 | _x_x_mozilla_page_load_details 15:18:49 INFO - PROCESS | 31575 | |i|pagename|runs| 15:18:49 INFO - PROCESS | 31575 | |0;dojo.html;2564.602486614575;2582.3673200065987;2595.9351016224596;2615.9738402615967;2625.251803236078;4592.72443653381;4645.581897629213;4647.860564183072;4672.439307283126;4701.38881945347;4691.483936766953;4695.882602934928;4714.245720684691;4758.928616070753;4839.830605928784;4258.297380932158;4285.035866929947;4328.04782947751;4352.151330490556;4361.49842768081;4398.208322501949;4453.48784889737;4457;4464.2633965395835;4466;4220.577942205786;4347.826086956518;4354.325079612665;4382.5398333175035;4445.466544014723;4258.744475331459;4338.349247612852;4338.370936214263;4341.02326976431;4343.022819865537;4262.445882035316;4314.266574682311;4319.200947824631;4320.1575692739925;4332.306830907071;4718.221493453576;4748.145333839908;4749.525047495257;4799.3041009053495;4808.543188397097;5087.414947281073;5102.311187989648;5114.769835357418;5123.487651234884;5150.97424512875;4918.336024636664;4973.3286006389035;5133.948660513422;5138.717370544656;5153.2270159476;4660.883477913011;4707.529247075299;4708.270218116198;4715.7877895494785;4785.856424307276;5104.2088476286235;5158.587313014949;5160.303359046556;5187.922181167285;5188.740562971836;4937.333459982929;4970.279309500174;4982.701037937735;4983.700977941335;5030.37120359955;4907.263910413395;4938.777755000961;4955.380577427822;4963.379577552806;5039.546440820343;4960.280759289883;5031.421386540522;5065.898682026339;5071.087204303187;5072.695638261716;5003.174476211384;5016.398032236082;5019.949800502021;5026.019926114445;5060.443351231435;4205.053862880827;4247.4265974093105;4325.978370108192;4342.761148136883;4376.387305777193;3707.573629032696;3735.9066023349633;3752.681022113151;3757.6618104370737;3818.3508803503473;4424.7123936944;4438;4438.955610443919;4439.156560253606;4478;5089.033083714083;5100.311457953203;5105.566026887682;5110.386753589519;5154.613403994716;4293.849715259951;4305.56944305567;4355.542668019875;4359.847405340798;4393.868183954486;4606.8157273708675;4607.0325231701045;4612.123696497655;4623.237165867594;4646.372739680168;4778.737169455644;4789.066132104345;4791.712497250106;4792.544708252711;4836.250381190921;4881.609471242363;4922.975385123052;4923.630727695366;4990.451050384382;5038.2190760432195;4714.882127946828;4766.785494652819;4787.8563643090765;4805.975970120127;4809.927851082307;4982.352294201875;4993.248341872178;4993.6254780892305;4994.500549944976;5037.420696619789;4959.454460009469;5056.140456122542;5063.265826455217;5069.797208111634;5113.667611605234;4834;4858.3441235432765;4862.732549709658;4871.439784424837;4903.31353610502;4871.756412179448;4874.4150701916;4878.170710979071;4884.0476107158765;4922.975385123052;4764.166270902509;4786.234202527578;4793.544613261734;4804.6876952997945;4856;4783.641226908066;4848.442429120555;4909.091818013679;4949.653524253267;4969.503049695001;4869.780859861244;4876.609871210366;4894.657373983787;4903.6077113831525;4904.386951631046 15:18:49 INFO - PROCESS | 31575 | |1;ext.html;547.2885249176071;568.6929058308514;570.8144852922799;574.9453801888819;578.3753546170136;27316;29836.701632983662;29851.701482985136;29863.253418664543;29876.850615746946;29589.85205073977;30237;30303;37773.811130944305;38855.80572097136;7580.924190758091;7710.190430004853;7713.34436572892;7713.42149338799;7716.305532502074;7553.8866916996285;7644.120926093487;7645.235476452338;7647.61761911905;7653.31120199182;7656.923430765704;7668.501547399429;7692.538447693129;7693.49992250502;7695.884561731578;7595.392368610525;7644.961775191144;7658.119316278588;7663.846723065563;7664.31021208094;7603;7664.846703065908;7669.118051424102;7670.4247181461615;7670.539767613961;36067.278654426766;36170.45744313837;36317.455238171446;36372.818135909154;36399.63600363989;2968.525035994252;3087.1818967973504;3243.367543329052;3592.1738000259825;3651.1054791576234;26712.20600242979;27270.5909411357;27299.31751706223;27306.726932730617;27319.590206146924;3425.2978139481597;3492.5808902931813;3613.9638603614153;3696.9815150924073;3701.8889433317045;239042;240836;241957.1119299618;242270;242350.99999999822;30096.398072038435;48969.75515122473;49184;49192.50807491879;49232.261516077284;30959;32860.50709239364;32879.178020549676;32895.177620559676;32908;11127.888721112686;11143.33140011602;11176.776464470666;11180.776384472427;11217.551297948154;8769.824603507894;8788.209061184523;8828.940527136785;8846.77883052916;8877.866831997526;7689.807754806175;7724.613769311624;7790.298873101448;7816.257455541714;7817.687292508236;2993;3035.2411897025745;3049.8017628854054;3077.7999430036975;3112.25305926576;804.3484777330381;821.2239433735183;906.727981605529;935.4995077633433;938.1790932933683;25380.74619253821;26698.733012669625;27158.5926211107;27258;27306.45387092247;723.5911709883899;936.3258453913172;936.8969413364524;965.4014511003223;1004.5680357446222;13632.522861699992;14205.573832785032;14233.78649320261;14489.492867749577;14491.130532168103;358166;359993;360556;363925;364226;47898.76050619724;48270.5172948273;48345.27482087771;48428;48940.26589601159;1050.5272627317738;1077.6820837853008;1088.4122573810055;1135.392564977733;1170.087331881134;24231.30380873322;28211.2947176314;28486.85756571204;28801.85599072075;28954.855225723735;40300;40762.79618601888;40769;40794.388084178165;40824.79587602043;220492;221354;221546;221601;221821;23951;24286.63570046486;24987.87506062458;25011.749882500942;26287;39958.800205998785;40188.79905600454;40273.395899062125;40392.596074038884;40804.38793418042;34721.305573887876;34741.305173896886;34897.65102348944;35276.11809704778;35283.823580882956;34606;34710.305793883475;34787.478187826695;34816;34835.825820870734;33742.49386259159;34011.82994085113;34277.65722342745;34367.65632343745;34597.82701086579;30133.397332053675;31798.682013180496;32371.676283237808;32393.838030809697;32434.675653243165;23940.640890387007;24281.878590606935;24755.504889902462;25160.496790064462;25164.49671006606 15:18:49 INFO - PROCESS | 31575 | |2;jquery.html;340.5419710489394;363.9854405823767;364.51701495518444;376.80406188781836;394.1820722001845;12514.4994200232;12577.11960162789;13010.284434356106;13260.204387736743;17212.13939303033;16091.678166436664;16296.429624963128;16359.91820040901;16370.83629163708;16489.505314840542;4847.175980083385;4881.633877459187;5013.699178049311;5042.84871453857;5045.192769156935;4955.132851750947;5046.873828154307;5050.520200580939;5050.621203409741;5053.216751403538;4962.206047032476;5315.0432922074015;5338.252644629755;5434.8913021739545;5436.91844622331;5324.973375133119;5361.463853614647;5370.865728356784;5371.033214021494;5565.526930210937;5191.610629202787;5208.374995000624;5220.843374698765;5246.501582349671;5249.68501889884;10330.483475826179;10507.369557826554;10782.514786834612;19245.903770481058;19422.766381866124;1749.553863764732;1772.7606773085597;1953.8143876331726;2000.669889468236;2358.681577986984;8862.335324850597;8981.955090224572;8987.550622468916;9312.394694344846;9434.575444105032;1704.4375356132446;1715.2195750933295;1725.8015328237288;1752.7283271093002;1759.7704127389027;63105.684471577806;66981.62729658793;67268.32731672718;68926;71178.64410677913;9645.807083858284;9679.661211857692;9863.7040888772;9956.084823548093;10047.748806279902;13552.186868787905;13569;13569.592912212649;13579.59261222165;13595.456181752817;6554.9672251639395;6568.737250510022;6751.25736169021;6772.458203343721;6782.728690852311;6068.120122582201;6117.113018612276;6211.720472578745;6237.75048998035;6247.219097612799;4139.97930010348;4187.45563076798;4237.915241695149;4300.65594752419;4374.4531933508315;1749.82501749824;1754.333353325728;1757.200473784425;1795.5870149865605;1812.6737187306412;802.5987006496752;838.4089217101929;875.444093000949;900.7477906186278;954.8329042417549;15621.218939053002;16043.679126417406;16054.919725401298;16609.252583633766;16675.582040604044;792.6393490961599;810.720301495983;832.6794184239111;833.2833762963846;852.4416507187802;8526.35682938291;8904.421212621159;9136.360454768235;9267.907320926839;9289.90710092904;360712;367518;367989;369693;372148;73369.63315183496;73435;74442.62778686071;75893.24106758862;76269.61865190639;850.7447765670274;865.8008658008567;866.5234121233296;867.0765634599258;869.6695255802881;13977.58067257984;14031.368588413341;14223.502177423741;14234.14595124296;14688.77966830477;34669;35193.82403087968;35478;35567.46648800322;40024;48943;50293;50596.24105638492;50677.74661126671;52739;7210.098737657793;7302.415806735342;7355.411567074514;7444.813879653052;7456.813579660552;9521.952390238004;10550.449570366003;11109.277896936674;11180.832287515856;11202.327860328407;9295.256379489489;9657.806843863224;9947.701568952943;10033.397996120257;10067.949660251652;9649.214895244402;9736.659216927374;9864.654737084167;10142.391456512632;10235.488225588542;9510.95244523773;9621.27840411958;9655.179309758469;10046.346987445793;10173.287869849335;7068.505204635626;7265.527740696838;7351.264873512606;7407.851842963219;7468.813279668052;8129.4715843469985;9833.60665573369;9915;9971.45157016371;10242 15:18:49 INFO - PROCESS | 31575 | |3;mootools.html;1155.3645494977761;1292.967675808105;1334.8798608125269;1360.7346567419352;1605.8956167849096;5868.207791948091;6610.471162307016;6789.558678685894;6829.078074459946;7022.964885175567;6891;6949.44404447643;6953.165620125579;6955.130608673916;6956.8956465653055;2100.69539916712;2108.1567373050825;2108.725865637465;2115.8307335413206;2123.2674727219087;2065.5249292662697;2124.3626911926362;2134.8398870084807;2138.518833262511;2141.389703934379;2007.9899600501976;2018.3541266794632;2020.8383329333617;2022.3427386099504;2023.5345870449805;2050.9794902051012;2064.298138632857;2072.782357852419;2073.0360382422173;2073.6889466579983;2072.0779253232317;2072.1814883121233;2101.5271563898154;2104.2529901884764;2107.725995620575;6639.435647969928;6789.18529776425;6842.726290948356;6911.928651059094;6954.061201737752;4229.090745489703;4358.389825424443;4368.230866499073;4368.301071828492;4372.737635741865;2664.267326485232;2831.8725657345467;2911.941761164786;2912.8397938113394;2921.1674672718386;896.2874514760781;907.9591418386123;912.16536868765;920.3741455810047;931.2177770672599;8587.22714955657;8690.348223883171;8718.694845680371;8772.517511536927;8783.912160878373;3718.9070273243387;3746.812659367021;3799.4490798834568;3841.769493830379;3854.479645247912;7154.749583764543;7164.140303163549;7183.784486465414;7209.0988626421695;7259.709611615476;4256.233877901946;4266.466691663542;4266.573342665709;4268.829246830154;4269.466316710411;3244.853981570835;3343.782654127474;3831.693464522887;3973.304671682444;3988.202359528106;3112.1130477813713;3169.35028319194;3284.687954644305;3292.86828526861;3305.6281643117836;1013.9493025348703;1021.9131373833159;1048.046277887119;1053.3100818963592;1056.1656291529605;685.1264637587117;716.9820754481076;747.3460721868365;781.8944442500303;784.4391260248949;4391.429114215131;4393.538678438782;4548.636109111263;4549.181147393501;4611.492735799059;409.62110048205886;417.49691621595906;420.3438452497151;421.2880232407222;426.5585119401405;2902.1293611916763;2914.4608247474284;2924.1373794730607;2971.1383698727127;3071.3550154467366;7770.300672939463;8092.3930705197345;8150.429469937166;8196.057453392817;8197.754067377988;8163.959180204061;8167.162388462667;8173.34613230952;8176.264136227768;8178.877316840252;6298.905516417258;6411.807645770635;6427.871442571122;6476.190476190476;6483.481321494269;4400;4449.976505403711;4511.819527219006;4517.864464066083;4529.705569137996;7358.632068396666;7594.430417718582;7651.61741912891;7669.769906902802;7670.769876903479;7743.45795794289;7791.337736292478;7812.101608315116;7864.21357864209;7865.488743231672;5201.7399130044105;5658.85852853682;5755.280589926259;5764.13537969308;5765;5995.520358371407;6163.229596300463;6164.352742961924;6176.35148309421;6178.135061091541;5533.225348451139;5744.454276843693;5787.594868359174;5830.18377427169;5964.970175149097;5765.682887441231;5808.506276966336;5826.126081087701;5890.587658863838;6003.249593800775;5132.9743351283005;5133.717645529532;5136.589072874236;5192.532672059533;5206.583473322049;3847.5960024197057;3898.4542164096483;3929.2730844792663;3948.26957012942;3982.7212095153063;3954.822033008579;3955.6472922712;3965.345717956505;3998.840046398228;4079 15:18:49 INFO - PROCESS | 31575 | |4;prototype.html;290.6483155381989;297.07609334968254;304.0725786351628;304.9313904371516;306.7883160619171;4793.32893394925;4836.814980329816;4842.104210721019;4881.438634557027;4896.926546101807;4802.135615589193;4806.279058141281;4831.396075490564;4845.757712114389;4846.297286893398;3563.608003119661;3577.6064632890493;3665.523481947343;3675.7426980111404;3730.142067324517;3719.0888232383104;3728.5525736911472;3736.5516138063335;3750.887473375803;3751.3247615429214;3694.963050369502;3695.224002959382;3706.666400023997;3712.721545884056;3718.4794128821986;3541.9197144870805;3653.451982202664;3672.3573374659327;3745.176061266517;3752.6810221131236;3310.702036816674;3312.3706495765728;3312.4368857294317;3318.286568387784;3318.568586083818;4712.6229901607785;4720.221163508017;4730.881727956794;4744.4069491313585;4815.109204797089;4181.707280490367;4281.957180428187;4292;4322.200392927319;4337.742054804103;4982.701037937735;4998.300577803528;5007.272490990639;5022.77397517109;5038.168702164138;3627.2020155565997;3632.110133017428;3638;3642.7814331139953;3645.4714066460215;5067.822626208102;5272.446393128743;5278.9208161877605;5289.259503669489;5321.308229930123;3595.5685317762036;3604.2971620534267;3610.7291953103095;3612.512310838003;3617.222297206061;3642.4354225095153;3646.3072016316814;3648.9817550912076;3653.7807731535663;3653.8173091345325;4094.467719196485;4224.78876056196;4226.344916537942;4227.725197862191;4235.30117530604;5028.270900719375;5050.641323519818;5065.696058236517;5078.908034772541;5087.516685914832;1218.451696736472;1227.821965814952;1228.9139760216879;1235.110720281396;1235.1971218707731;759.1345865713091;801.4950581133965;839.4082172068677;856.3985347400277;859.9183077607618;4160.355144952538;4414.426124603781;4506.662000349987;4507.881295790973;4533.818647254139;5209.348831396075;5215.269862219292;5224.764885580158;5225.451327610622;5232.843014709565;4383.802728877208;4550.340200670884;4559.224931761609;4560.1335746208115;4568.657350698711;2652.602109683563;2677.799165062628;2678.772304354152;2686.489566982267;2689.2335684330264;4726.456457507431;4745.572898439157;4749.667523273338;4754.263089221176;4760.738159401197;4869.391326084239;5132.461091585405;5133.12736834739;5177.275181474596;5188.11801993662;4718.669693121517;4748.19280722278;4751.809927602926;4768.8092476301945;4769.642276829251;5034.471380505141;5044.798208071783;5059.418166910705;5074.137396642654;5088.745562721923;4855.34452848875;4924.384451943507;4986.850394488171;5012.824551140839;5018.42288136869;4858.17411040117;4881.8535443936735;4897.2654101885;4910.404118661378;4921.360223170965;3641.7450778445254;3659.432787917877;3662.589902887354;3692.8338224780487;3721.106934335794;5107.87230319245;5300.997746701216;5304.443033481429;5306.416294207557;5330.9733451332495;5000.5999520037585;5037.420696619935;5089.465606111453;5118.97440512795;5140.871478212925;5058.317127187783;5064.265681476239;5069.645124841226;5097.796088156432;5103.5661968733075;4735.526447355237;5021.196608542616;5032.924506132485;5038.899222015612;5055.368078990126;4877.439094504178;4946.208606622923;4972.204447288416;5089.414717307557;5116;4945.19500382365;4965.851024469272;4986;4996.075725990703;4997.900461898376 15:18:49 INFO - PROCESS | 31575 | |5;yui.html;637.8309747916801;648.854007848234;651.3128649275013;676.9999999999997;731.9707211711532;11811.822822657656;12418.81371779424;12450.315232662211;12450.564230251943;12494.250344979308;11689.473973671184;11729.824052639216;11828.408579571009;11834.467448964795;11847.170698051139;602.5631417222522;621.4872729997747;723.8950352198941;727.7925791149523;753.15270320889;749.5689978262494;751.943604229685;754.7169811320755;754.9547027178387;755.4598462099598;793.5040599625235;794.6185830801219;795.2326005404783;795.2842441802367;796.6375299238832;625.0748891640352;644.3427703742157;782.7025730222507;782.8864814601908;783.0916137280784;481.4727872979082;481.72060205081317;481.78560540559465;554.2102503931922;570.4609144358583;12380.133390662657;12405.069619778462;12433.689157771038;12451.501939922393;12481.50073997039;11367.261128026652;11486.827697584544;11690.707732306675;11799.233049851731;11960.70098247542;9157.725268241897;9408.764780880465;10663.733406664818;10687.251892367538;10866.891331086666;3988.3219852625125;4005.9799701001307;4080.3471444569022;4114;4248.532661407243;45775.54224457746;46577.040951519164;47436.05127897457;47597;47644.047119057424;8974.86537701935;9584.76038099053;9845.60617575289;9955.303128780915;10075.949620251999;17474.301027958994;17619;17759.289628414976;17813.287468501374;17832.732509012374;6440.516961227927;6451.322611125858;6595.472362211011;6774.356436138559;6817.625030623363;3554.4668299755244;3612.837422316002;3645.3256147612246;3683.7053035757076;3724.478572999782;2725;2812.6202962599787;2893.1899068260923;3041.194083567856;3048.481758101128;529.3515443581658;532.7043490862609;535.700007995516;536.4608568388744;541.8211990043276;543.4212563619732;553.3111276460832;574.2161948939668;583.7781642975727;589.9999500846111;6469.741210351627;6520.902186467112;6629.569078009914;6743.561668491532;6835.077264569319;496.61760444457565;517.7152566088636;567.7416775367197;574.1559906936797;574.3022227993008;3143.7170654640736;3148.2286839723956;3191;3302.570665813477;3319.253168037221;64983;68225.65887170532;68868;69573;70495.64752176206;35542.64457355393;37180;43147.35278970818;51630.48369516332;60757.69621151866;55749;56278;56916.71541642265;58307.70846145827;59233.40766592451;6270.686465676789;6444.742210311722;6511.804645860631;6530.542861999615;6587.868242635216;38156.6184338153;38549;38640.61359386483;38757.22485550329;39328;49538.25692614542;50473;51759.74120129375;52048.479515204366;52347.738261309976;8538.316934645338;8741.169588889044;9009.684661036832;9031.864522032043;9162.67930622425;9674.129328360481;9772.654562904994;9965.451900145561;10054.54754536033;10114.8482772757;8692.130786921258;8826.691065812665;8844.646214151619;8897.199252067345;8909.866352004854;9367.344285900193;9526.190273826802;9541.427514349161;9945.602175912882;10064.69805905824;7862.33170180541;8026.518408895485;8475.618597163018;8574.09971952936;8610.827783444422;7277.963610181915;7508.962455187689;7575.431842611936;7618.390528757575;7834.921650783419;7157.677904494206;7265.491415600857;7346.926530734624;7415.443841711785;7441.925580744123 15:18:49 INFO - PROCESS | 31575 | __end_tp_report 15:18:49 INFO - PROCESS | 31575 | __start_cc_report 15:18:49 INFO - PROCESS | 31575 | _x_x_mozilla_cycle_collect,1442 15:18:49 INFO - PROCESS | 31575 | __end_cc_report 15:18:49 INFO - PROCESS | 31575 | __startTimestamp1478647129988__endTimestamp 15:18:49 INFO - PROCESS | 31575 | 15:18:49 INFO - PROCESS | 31575 | ------- Summary: start ------- 15:18:50 INFO - PROCESS | 31575 | Number of tests: 6 15:18:50 INFO - PROCESS | 31575 | 15:18:50 INFO - PROCESS | 31575 | [#0] dojo.html Cycles:165 Average:4668.14 Median:4793.54 stddev:488.52 (10.2%) stddev-sans-first:461.31 15:18:50 INFO - PROCESS | 31575 | Values: 2564.6 2582.4 2595.9 2616.0 2625.3 4592.7 4645.6 4647.9 4672.4 4701.4 4691.5 4695.9 4714.2 4758.9 4839.8 4258.3 4285.0 4328.0 4352.2 4361.5 4398.2 4453.5 4457.0 4464.3 4466.0 4220.6 4347.8 4354.3 4382.5 4445.5 4258.7 4338.3 4338.4 4341.0 4343.0 4262.4 4314.3 4319.2 4320.2 4332.3 4718.2 4748.1 4749.5 4799.3 4808.5 5087.4 5102.3 5114.8 5123.5 5151.0 4918.3 4973.3 5133.9 5138.7 5153.2 4660.9 4707.5 4708.3 4715.8 4785.9 5104.2 5158.6 5160.3 5187.9 5188.7 4937.3 4970.3 4982.7 4983.7 5030.4 4907.3 4938.8 4955.4 4963.4 5039.5 4960.3 5031.4 5065.9 5071.1 5072.7 5003.2 5016.4 5019.9 5026.0 5060.4 4205.1 4247.4 4326.0 4342.8 4376.4 3707.6 3735.9 3752.7 3757.7 3818.4 4424.7 4438.0 4439.0 4439.2 4478.0 5089.0 5100.3 5105.6 5110.4 5154.6 4293.8 4305.6 4355.5 4359.8 4393.9 4606.8 4607.0 4612.1 4623.2 4646.4 4778.7 4789.1 4791.7 4792.5 4836.3 4881.6 4923.0 4923.6 4990.5 5038.2 4714.9 4766.8 4787.9 4806.0 4809.9 4982.4 4993.2 4993.6 4994.5 5037.4 4959.5 5056.1 5063.3 5069.8 5113.7 4834.0 4858.3 4862.7 4871.4 4903.3 4871.8 4874.4 4878.2 4884.0 4923.0 4764.2 4786.2 4793.5 4804.7 4856.0 4783.6 4848.4 4909.1 4949.7 4969.5 4869.8 4876.6 4894.7 4903.6 4904.4 15:18:50 INFO - PROCESS | 31575 | 15:18:50 INFO - PROCESS | 31575 | [#1] ext.html Cycles:180 Average:41414.12 Median:34866.74 stddev:74188.74 (212.8%) stddev-sans-first:74333.41 15:18:50 INFO - PROCESS | 31575 | Values: 547.3 568.7 570.8 574.9 578.4 27316.0 29836.7 29851.7 29863.3 29876.9 29589.9 30237.0 30303.0 37773.8 38855.8 7580.9 7710.2 7713.3 7713.4 7716.3 7553.9 7644.1 7645.2 7647.6 7653.3 7656.9 7668.5 7692.5 7693.5 7695.9 7595.4 7645.0 7658.1 7663.8 7664.3 7603.0 7664.8 7669.1 7670.4 7670.5 36067.3 36170.5 36317.5 36372.8 36399.6 2968.5 3087.2 3243.4 3592.2 3651.1 26712.2 27270.6 27299.3 27306.7 27319.6 3425.3 3492.6 3614.0 3697.0 3701.9 239042.0 240836.0 241957.1 242270.0 242351.0 30096.4 48969.8 49184.0 49192.5 49232.3 30959.0 32860.5 32879.2 32895.2 32908.0 11127.9 11143.3 11176.8 11180.8 11217.6 8769.8 8788.2 8828.9 8846.8 8877.9 7689.8 7724.6 7790.3 7816.3 7817.7 2993.0 3035.2 3049.8 3077.8 3112.3 804.3 821.2 906.7 935.5 938.2 25380.7 26698.7 27158.6 27258.0 27306.5 723.6 936.3 936.9 965.4 1004.6 13632.5 14205.6 14233.8 14489.5 14491.1 358166.0 359993.0 360556.0 363925.0 364226.0 47898.8 48270.5 48345.3 48428.0 48940.3 1050.5 1077.7 1088.4 1135.4 1170.1 24231.3 28211.3 28486.9 28801.9 28954.9 40300.0 40762.8 40769.0 40794.4 40824.8 220492.0 221354.0 221546.0 221601.0 221821.0 23951.0 24286.6 24987.9 25011.7 26287.0 39958.8 40188.8 40273.4 40392.6 40804.4 34721.3 34741.3 34897.7 35276.1 35283.8 34606.0 34710.3 34787.5 34816.0 34835.8 33742.5 34011.8 34277.7 34367.7 34597.8 30133.4 31798.7 32371.7 32393.8 32434.7 23940.6 24281.9 24755.5 25160.5 25164.5 15:18:50 INFO - PROCESS | 31575 | 15:18:50 INFO - PROCESS | 31575 | [#2] jquery.html Cycles:180 Average:23018.25 Median:50636.99 stddev:60845.85 (120.2%) stddev-sans-first:60992.71 15:18:50 INFO - PROCESS | 31575 | Values: 340.5 364.0 364.5 376.8 394.2 12514.5 12577.1 13010.3 13260.2 17212.1 16091.7 16296.4 16359.9 16370.8 16489.5 4847.2 4881.6 5013.7 5042.8 5045.2 4955.1 5046.9 5050.5 5050.6 5053.2 4962.2 5315.0 5338.3 5434.9 5436.9 5325.0 5361.5 5370.9 5371.0 5565.5 5191.6 5208.4 5220.8 5246.5 5249.7 10330.5 10507.4 10782.5 19245.9 19422.8 1749.6 1772.8 1953.8 2000.7 2358.7 8862.3 8982.0 8987.6 9312.4 9434.6 1704.4 1715.2 1725.8 1752.7 1759.8 63105.7 66981.6 67268.3 68926.0 71178.6 9645.8 9679.7 9863.7 9956.1 10047.7 13552.2 13569.0 13569.6 13579.6 13595.5 6555.0 6568.7 6751.3 6772.5 6782.7 6068.1 6117.1 6211.7 6237.8 6247.2 4140.0 4187.5 4237.9 4300.7 4374.5 1749.8 1754.3 1757.2 1795.6 1812.7 802.6 838.4 875.4 900.7 954.8 15621.2 16043.7 16054.9 16609.3 16675.6 792.6 810.7 832.7 833.3 852.4 8526.4 8904.4 9136.4 9267.9 9289.9 360712.0 367518.0 367989.0 369693.0 372148.0 73369.6 73435.0 74442.6 75893.2 76269.6 850.7 865.8 866.5 867.1 869.7 13977.6 14031.4 14223.5 14234.1 14688.8 34669.0 35193.8 35478.0 35567.5 40024.0 48943.0 50293.0 50596.2 50677.7 52739.0 7210.1 7302.4 7355.4 7444.8 7456.8 9522.0 10550.4 11109.3 11180.8 11202.3 9295.3 9657.8 9947.7 10033.4 10067.9 9649.2 9736.7 9864.7 10142.4 10235.5 9511.0 9621.3 9655.2 10046.3 10173.3 7068.5 7265.5 7351.3 7407.9 7468.8 8129.5 9833.6 9915.0 9971.5 10242.0 15:18:50 INFO - PROCESS | 31575 | 15:18:50 INFO - PROCESS | 31575 | [#3] mootools.html Cycles:180 Average:4439.13 Median:4523.79 stddev:2380.90 (52.6%) stddev-sans-first:2374.78 15:18:50 INFO - PROCESS | 31575 | Values: 1155.4 1293.0 1334.9 1360.7 1605.9 5868.2 6610.5 6789.6 6829.1 7023.0 6891.0 6949.4 6953.2 6955.1 6956.9 2100.7 2108.2 2108.7 2115.8 2123.3 2065.5 2124.4 2134.8 2138.5 2141.4 2008.0 2018.4 2020.8 2022.3 2023.5 2051.0 2064.3 2072.8 2073.0 2073.7 2072.1 2072.2 2101.5 2104.3 2107.7 6639.4 6789.2 6842.7 6911.9 6954.1 4229.1 4358.4 4368.2 4368.3 4372.7 2664.3 2831.9 2911.9 2912.8 2921.2 896.3 908.0 912.2 920.4 931.2 8587.2 8690.3 8718.7 8772.5 8783.9 3718.9 3746.8 3799.4 3841.8 3854.5 7154.7 7164.1 7183.8 7209.1 7259.7 4256.2 4266.5 4266.6 4268.8 4269.5 3244.9 3343.8 3831.7 3973.3 3988.2 3112.1 3169.4 3284.7 3292.9 3305.6 1013.9 1021.9 1048.0 1053.3 1056.2 685.1 717.0 747.3 781.9 784.4 4391.4 4393.5 4548.6 4549.2 4611.5 409.6 417.5 420.3 421.3 426.6 2902.1 2914.5 2924.1 2971.1 3071.4 7770.3 8092.4 8150.4 8196.1 8197.8 8164.0 8167.2 8173.3 8176.3 8178.9 6298.9 6411.8 6427.9 6476.2 6483.5 4400.0 4450.0 4511.8 4517.9 4529.7 7358.6 7594.4 7651.6 7669.8 7670.8 7743.5 7791.3 7812.1 7864.2 7865.5 5201.7 5658.9 5755.3 5764.1 5765.0 5995.5 6163.2 6164.4 6176.4 6178.1 5533.2 5744.5 5787.6 5830.2 5965.0 5765.7 5808.5 5826.1 5890.6 6003.2 5133.0 5133.7 5136.6 5192.5 5206.6 3847.6 3898.5 3929.3 3948.3 3982.7 3954.8 3955.6 3965.3 3998.8 4079.0 15:18:50 INFO - PROCESS | 31575 | 15:18:50 INFO - PROCESS | 31575 | [#4] prototype.html Cycles:180 Average:4165.60 Median:4753.04 stddev:1221.93 (25.7%) stddev-sans-first:1190.24 15:18:50 INFO - PROCESS | 31575 | Values: 290.6 297.1 304.1 304.9 306.8 4793.3 4836.8 4842.1 4881.4 4896.9 4802.1 4806.3 4831.4 4845.8 4846.3 3563.6 3577.6 3665.5 3675.7 3730.1 3719.1 3728.6 3736.6 3750.9 3751.3 3695.0 3695.2 3706.7 3712.7 3718.5 3541.9 3653.5 3672.4 3745.2 3752.7 3310.7 3312.4 3312.4 3318.3 3318.6 4712.6 4720.2 4730.9 4744.4 4815.1 4181.7 4282.0 4292.0 4322.2 4337.7 4982.7 4998.3 5007.3 5022.8 5038.2 3627.2 3632.1 3638.0 3642.8 3645.5 5067.8 5272.4 5278.9 5289.3 5321.3 3595.6 3604.3 3610.7 3612.5 3617.2 3642.4 3646.3 3649.0 3653.8 3653.8 4094.5 4224.8 4226.3 4227.7 4235.3 5028.3 5050.6 5065.7 5078.9 5087.5 1218.5 1227.8 1228.9 1235.1 1235.2 759.1 801.5 839.4 856.4 859.9 4160.4 4414.4 4506.7 4507.9 4533.8 5209.3 5215.3 5224.8 5225.5 5232.8 4383.8 4550.3 4559.2 4560.1 4568.7 2652.6 2677.8 2678.8 2686.5 2689.2 4726.5 4745.6 4749.7 4754.3 4760.7 4869.4 5132.5 5133.1 5177.3 5188.1 4718.7 4748.2 4751.8 4768.8 4769.6 5034.5 5044.8 5059.4 5074.1 5088.7 4855.3 4924.4 4986.9 5012.8 5018.4 4858.2 4881.9 4897.3 4910.4 4921.4 3641.7 3659.4 3662.6 3692.8 3721.1 5107.9 5301.0 5304.4 5306.4 5331.0 5000.6 5037.4 5089.5 5119.0 5140.9 5058.3 5064.3 5069.6 5097.8 5103.6 4735.5 5021.2 5032.9 5038.9 5055.4 4877.4 4946.2 4972.2 5089.4 5116.0 4945.2 4965.9 4986.0 4996.1 4997.9 15:18:50 INFO - PROCESS | 31575 | 15:18:50 INFO - PROCESS | 31575 | [#5] yui.html Cycles:180 Average:13721.03 Median:574.26 stddev:17925.42 (3121.5%) stddev-sans-first:17948.78 15:18:50 INFO - PROCESS | 31575 | Values: 637.8 648.9 651.3 677.0 732.0 11811.8 12418.8 12450.3 12450.6 12494.3 11689.5 11729.8 11828.4 11834.5 11847.2 602.6 621.5 723.9 727.8 753.2 749.6 751.9 754.7 755.0 755.5 793.5 794.6 795.2 795.3 796.6 625.1 644.3 782.7 782.9 783.1 481.5 481.7 481.8 554.2 570.5 12380.1 12405.1 12433.7 12451.5 12481.5 11367.3 11486.8 11690.7 11799.2 11960.7 9157.7 9408.8 10663.7 10687.3 10866.9 3988.3 4006.0 4080.3 4114.0 4248.5 45775.5 46577.0 47436.1 47597.0 47644.0 8974.9 9584.8 9845.6 9955.3 10075.9 17474.3 17619.0 17759.3 17813.3 17832.7 6440.5 6451.3 6595.5 6774.4 6817.6 3554.5 3612.8 3645.3 3683.7 3724.5 2725.0 2812.6 2893.2 3041.2 3048.5 529.4 532.7 535.7 536.5 541.8 543.4 553.3 574.2 583.8 590.0 6469.7 6520.9 6629.6 6743.6 6835.1 496.6 517.7 567.7 574.2 574.3 3143.7 3148.2 3191.0 3302.6 3319.3 64983.0 68225.7 68868.0 69573.0 70495.6 35542.6 37180.0 43147.4 51630.5 60757.7 55749.0 56278.0 56916.7 58307.7 59233.4 6270.7 6444.7 6511.8 6530.5 6587.9 38156.6 38549.0 38640.6 38757.2 39328.0 49538.3 50473.0 51759.7 52048.5 52347.7 8538.3 8741.2 9009.7 9031.9 9162.7 9674.1 9772.7 9965.5 10054.5 10114.8 8692.1 8826.7 8844.6 8897.2 8909.9 9367.3 9526.2 9541.4 9945.6 10064.7 7862.3 8026.5 8475.6 8574.1 8610.8 7278.0 7509.0 7575.4 7618.4 7834.9 7157.7 7265.5 7346.9 7415.4 7441.9 15:18:50 INFO - PROCESS | 31575 | -------- Summary: end -------- 15:18:50 INFO - PROCESS | 31575 | 15:18:50 INFO - TEST-INFO | 31575: exit 0 15:18:51 INFO - TEST-OK | dromaeo_css | took 1122130ms 15:18:51 INFO - TEST-START | kraken 15:18:51 INFO - operating with platform_type : linux_ 15:18:51 INFO - Initialising browser for kraken test... 15:18:51 INFO - TEST-INFO | started process 31889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Y7wY2/profile http://localhost:51280/getInfo.html) 15:18:55 INFO - PROCESS | 31889 | __metrics Screen width/height:1600/1200 15:18:55 INFO - PROCESS | 31889 | colorDepth:24 15:18:55 INFO - PROCESS | 31889 | Browser inner width/height: 1024/697 15:18:55 INFO - PROCESS | 31889 | __metrics 15:18:55 INFO - PROCESS | 31889 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:18:55 INFO - PROCESS | 31889 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:18:56 INFO - PROCESS | 31889 | console.error: PushService: 15:18:56 INFO - PROCESS | 31889 | stateChangeProcessEnqueue: Error transitioning state 15:18:56 INFO - PROCESS | 31889 | UnknownError 15:18:56 INFO - TEST-INFO | 31889: exit 0 15:18:56 INFO - Browser initialized. 15:18:56 INFO - Running cycle 1/1 for kraken test... 15:18:56 INFO - TEST-INFO | started process 31971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Y7wY2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:19:09 INFO - PROCESS | 31971 | RSS: Main: 174407680 15:19:09 INFO - PROCESS | 31971 | 15:19:12 INFO - PROCESS | 31971 | Cycle 1(1): loaded http://localhost:51280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51280/tests/kraken/driver.html?testName=audio-beat-detection) 15:19:12 INFO - PROCESS | 31971 | RSS: Main: 230711296 15:19:12 INFO - PROCESS | 31971 | 15:19:15 INFO - PROCESS | 31971 | Cycle 1(1): loaded http://localhost:51280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51280/tests/kraken/driver.html?testName=audio-dft) 15:19:16 INFO - PROCESS | 31971 | RSS: Main: 218345472 15:19:16 INFO - PROCESS | 31971 | 15:19:19 INFO - PROCESS | 31971 | Cycle 1(1): loaded http://localhost:51280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51280/tests/kraken/driver.html?testName=audio-fft) 15:19:20 INFO - PROCESS | 31971 | RSS: Main: 300281856 15:19:20 INFO - PROCESS | 31971 | 15:19:22 INFO - PROCESS | 31971 | Cycle 1(1): loaded http://localhost:51280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51280/tests/kraken/driver.html?testName=audio-oscillator) 15:19:23 INFO - PROCESS | 31971 | RSS: Main: 211009536 15:19:23 INFO - PROCESS | 31971 | 15:19:25 INFO - PROCESS | 31971 | Cycle 1(1): loaded http://localhost:51280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:19:25 INFO - PROCESS | 31971 | RSS: Main: 214020096 15:19:25 INFO - PROCESS | 31971 | 15:19:29 INFO - PROCESS | 31971 | Cycle 1(1): loaded http://localhost:51280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51280/tests/kraken/driver.html?testName=imaging-darkroom) 15:19:29 INFO - PROCESS | 31971 | RSS: Main: 249745408 15:19:29 INFO - PROCESS | 31971 | 15:19:33 INFO - PROCESS | 31971 | Cycle 1(1): loaded http://localhost:51280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51280/tests/kraken/driver.html?testName=imaging-desaturate) 15:19:33 INFO - PROCESS | 31971 | RSS: Main: 248602624 15:19:33 INFO - PROCESS | 31971 | 15:19:36 INFO - PROCESS | 31971 | Cycle 1(1): loaded http://localhost:51280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51280/tests/kraken/driver.html?testName=json-parse-financial) 15:19:37 INFO - PROCESS | 31971 | RSS: Main: 248631296 15:19:37 INFO - PROCESS | 31971 | 15:19:38 INFO - PROCESS | 31971 | Cycle 1(1): loaded http://localhost:51280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:19:39 INFO - PROCESS | 31971 | RSS: Main: 210923520 15:19:39 INFO - PROCESS | 31971 | 15:19:41 INFO - PROCESS | 31971 | Cycle 1(1): loaded http://localhost:51280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51280/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:19:42 INFO - PROCESS | 31971 | RSS: Main: 218501120 15:19:42 INFO - PROCESS | 31971 | 15:19:44 INFO - PROCESS | 31971 | Cycle 1(1): loaded http://localhost:51280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:19:44 INFO - PROCESS | 31971 | RSS: Main: 226426880 15:19:44 INFO - PROCESS | 31971 | 15:19:47 INFO - PROCESS | 31971 | Cycle 1(1): loaded http://localhost:51280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:19:48 INFO - PROCESS | 31971 | RSS: Main: 231170048 15:19:48 INFO - PROCESS | 31971 | 15:19:51 INFO - PROCESS | 31971 | Cycle 1(1): loaded http://localhost:51280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:19:52 INFO - PROCESS | 31971 | RSS: Main: 232210432 15:19:52 INFO - PROCESS | 31971 | 15:19:53 INFO - PROCESS | 31971 | Cycle 1(1): loaded http://localhost:51280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51280/tests/kraken/driver.html?testName=ai-astar) 15:19:54 INFO - PROCESS | 31971 | RSS: Main: 282443776 15:19:54 INFO - PROCESS | 31971 | 15:19:54 INFO - PROCESS | 31971 | __start_tp_report 15:19:54 INFO - PROCESS | 31971 | _x_x_mozilla_page_load 15:19:54 INFO - PROCESS | 31971 | _x_x_mozilla_page_load_details 15:19:54 INFO - PROCESS | 31971 | |i|pagename|runs| 15:19:54 INFO - PROCESS | 31971 | |0;ai-astar;106;113;116;115;114;118;114;113;116;114 15:19:54 INFO - PROCESS | 31971 | |1;audio-beat-detection;154;130;130;172;130;132;127;130;166;134 15:19:54 INFO - PROCESS | 31971 | |2;audio-dft;163;162;163;163;161;161;162;161;162;159 15:19:54 INFO - PROCESS | 31971 | |3;audio-fft;76;76;75;123;75;76;76;76;99;76 15:19:54 INFO - PROCESS | 31971 | |4;audio-oscillator;85;82;120;84;83;83;103;83;83;119 15:19:54 INFO - PROCESS | 31971 | |5;imaging-gaussian-blur;117;118;118;117;117;118;118;119;117;118 15:19:54 INFO - PROCESS | 31971 | |6;imaging-darkroom;148;147;147;148;148;147;147;148;148;147 15:19:54 INFO - PROCESS | 31971 | |7;imaging-desaturate;85;85;84;85;85;85;84;84;84;84 15:19:54 INFO - PROCESS | 31971 | |8;json-parse-financial;66;66;65;66;67;68;67;66;67;66 15:19:54 INFO - PROCESS | 31971 | |9;json-stringify-tinderbox;66;67;66;67;67;66;67;67;68;67 15:19:54 INFO - PROCESS | 31971 | |10;stanford-crypto-aes;83;83;87;99;86;89;83;91;83;82 15:19:54 INFO - PROCESS | 31971 | |11;stanford-crypto-ccm;143;142;147;149;141;149;140;140;227;140 15:19:54 INFO - PROCESS | 31971 | |12;stanford-crypto-pbkdf2;183;179;175;177;177;175;176;178;181;178 15:19:54 INFO - PROCESS | 31971 | |13;stanford-crypto-sha256-iterative;73;70;74;69;81;69;69;70;69;68 15:19:54 INFO - PROCESS | 31971 | __end_tp_report 15:19:54 INFO - PROCESS | 31971 | __start_cc_report 15:19:54 INFO - PROCESS | 31971 | _x_x_mozilla_cycle_collect,1977 15:19:54 INFO - PROCESS | 31971 | __end_cc_report 15:19:54 INFO - PROCESS | 31971 | __startTimestamp1478647194184__endTimestamp 15:19:54 INFO - PROCESS | 31971 | 15:19:54 INFO - PROCESS | 31971 | ------- Summary: start ------- 15:19:54 INFO - PROCESS | 31971 | Number of tests: 14 15:19:54 INFO - PROCESS | 31971 | 15:19:54 INFO - PROCESS | 31971 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.50 stddev:3.18 (2.8%) stddev-sans-first:1.64 15:19:54 INFO - PROCESS | 31971 | Values: 106.0 113.0 116.0 115.0 114.0 118.0 114.0 113.0 116.0 114.0 15:19:54 INFO - PROCESS | 31971 | 15:19:54 INFO - PROCESS | 31971 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:133.00 stddev:16.87 (12.7%) stddev-sans-first:17.18 15:19:54 INFO - PROCESS | 31971 | Values: 154.0 130.0 130.0 172.0 130.0 132.0 127.0 130.0 166.0 134.0 15:19:54 INFO - PROCESS | 31971 | 15:19:54 INFO - PROCESS | 31971 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.24 15:19:54 INFO - PROCESS | 31971 | Values: 163.0 162.0 163.0 163.0 161.0 161.0 162.0 161.0 162.0 159.0 15:19:54 INFO - PROCESS | 31971 | 15:19:54 INFO - PROCESS | 31971 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:15.91 (20.9%) stddev-sans-first:16.68 15:19:54 INFO - PROCESS | 31971 | Values: 76.0 76.0 75.0 123.0 75.0 76.0 76.0 76.0 99.0 76.0 15:19:54 INFO - PROCESS | 31971 | 15:19:54 INFO - PROCESS | 31971 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:83.00 stddev:15.52 (18.7%) stddev-sans-first:16.22 15:19:54 INFO - PROCESS | 31971 | Values: 85.0 82.0 120.0 84.0 83.0 83.0 103.0 83.0 83.0 119.0 15:19:54 INFO - PROCESS | 31971 | 15:19:54 INFO - PROCESS | 31971 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 15:19:54 INFO - PROCESS | 31971 | Values: 117.0 118.0 118.0 117.0 117.0 118.0 118.0 119.0 117.0 118.0 15:19:54 INFO - PROCESS | 31971 | 15:19:54 INFO - PROCESS | 31971 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 15:19:54 INFO - PROCESS | 31971 | Values: 148.0 147.0 147.0 148.0 148.0 147.0 147.0 148.0 148.0 147.0 15:19:54 INFO - PROCESS | 31971 | 15:19:54 INFO - PROCESS | 31971 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 15:19:54 INFO - PROCESS | 31971 | Values: 85.0 85.0 84.0 85.0 85.0 85.0 84.0 84.0 84.0 84.0 15:19:54 INFO - PROCESS | 31971 | 15:19:54 INFO - PROCESS | 31971 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:66.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 15:19:54 INFO - PROCESS | 31971 | Values: 66.0 66.0 65.0 66.0 67.0 68.0 67.0 66.0 67.0 66.0 15:19:54 INFO - PROCESS | 31971 | 15:19:54 INFO - PROCESS | 31971 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 15:19:54 INFO - PROCESS | 31971 | Values: 66.0 67.0 66.0 67.0 67.0 66.0 67.0 67.0 68.0 67.0 15:19:54 INFO - PROCESS | 31971 | 15:19:54 INFO - PROCESS | 31971 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:86.50 stddev:5.30 (6.1%) stddev-sans-first:5.45 15:19:54 INFO - PROCESS | 31971 | Values: 83.0 83.0 87.0 99.0 86.0 89.0 83.0 91.0 83.0 82.0 15:19:54 INFO - PROCESS | 31971 | 15:19:54 INFO - PROCESS | 31971 | [#11] stanford-crypto-ccm Cycles:10 Average:151.80 Median:145.00 stddev:26.67 (18.4%) stddev-sans-first:28.10 15:19:54 INFO - PROCESS | 31971 | Values: 143.0 142.0 147.0 149.0 141.0 149.0 140.0 140.0 227.0 140.0 15:19:54 INFO - PROCESS | 31971 | 15:19:54 INFO - PROCESS | 31971 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.90 Median:178.00 stddev:2.56 (1.4%) stddev-sans-first:1.94 15:19:54 INFO - PROCESS | 31971 | Values: 183.0 179.0 175.0 177.0 177.0 175.0 176.0 178.0 181.0 178.0 15:19:54 INFO - PROCESS | 31971 | 15:19:54 INFO - PROCESS | 31971 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:70.00 stddev:3.94 (5.6%) stddev-sans-first:4.12 15:19:54 INFO - PROCESS | 31971 | Values: 73.0 70.0 74.0 69.0 81.0 69.0 69.0 70.0 69.0 68.0 15:19:54 INFO - PROCESS | 31971 | -------- Summary: end -------- 15:19:54 INFO - PROCESS | 31971 | 15:19:55 INFO - TEST-INFO | 31971: exit 0 15:19:55 INFO - TEST-OK | kraken | took 64557ms 15:19:55 INFO - SUITE-END | took 1186s 15:19:55 INFO - Completed test suite (00:19:46) 15:19:55 INFO - javascript benchmark 15:19:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2564.602486614575, 2582.3673200065987, 2595.9351016224596, 2615.9738402615967, 2625.251803236078, 4592.72443653381, 4645.581897629213, 4647.860564183072, 4672.439307283126, 4701.38881945347, 4691.483936766953, 4695.882602934928, 4714.245720684691, 4758.928616070753, 4839.830605928784, 4258.297380932158, 4285.035866929947, 4328.04782947751, 4352.151330490556, 4361.49842768081, 4398.208322501949, 4453.48784889737, 4457.0, 4464.2633965395835, 4466.0, 4220.577942205786, 4347.826086956518, 4354.325079612665, 4382.5398333175035, 4445.466544014723, 4258.744475331459, 4338.349247612852, 4338.370936214263, 4341.02326976431, 4343.022819865537, 4262.445882035316, 4314.266574682311, 4319.200947824631, 4320.1575692739925, 4332.306830907071, 4718.221493453576, 4748.145333839908, 4749.525047495257, 4799.3041009053495, 4808.543188397097, 5087.414947281073, 5102.311187989648, 5114.769835357418, 5123.487651234884, 5150.97424512875, 4918.336024636664, 4973.3286006389035, 5133.948660513422, 5138.717370544656, 5153.2270159476, 4660.883477913011, 4707.529247075299, 4708.270218116198, 4715.7877895494785, 4785.856424307276, 5104.2088476286235, 5158.587313014949, 5160.303359046556, 5187.922181167285, 5188.740562971836, 4937.333459982929, 4970.279309500174, 4982.701037937735, 4983.700977941335, 5030.37120359955, 4907.263910413395, 4938.777755000961, 4955.380577427822, 4963.379577552806, 5039.546440820343, 4960.280759289883, 5031.421386540522, 5065.898682026339, 5071.087204303187, 5072.695638261716, 5003.174476211384, 5016.398032236082, 5019.949800502021, 5026.019926114445, 5060.443351231435, 4205.053862880827, 4247.4265974093105, 4325.978370108192, 4342.761148136883, 4376.387305777193, 3707.573629032696, 3735.9066023349633, 3752.681022113151, 3757.6618104370737, 3818.3508803503473, 4424.7123936944, 4438.0, 4438.955610443919, 4439.156560253606, 4478.0, 5089.033083714083, 5100.311457953203, 5105.566026887682, 5110.386753589519, 5154.613403994716, 4293.849715259951, 4305.56944305567, 4355.542668019875, 4359.847405340798, 4393.868183954486, 4606.8157273708675, 4607.0325231701045, 4612.123696497655, 4623.237165867594, 4646.372739680168, 4778.737169455644, 4789.066132104345, 4791.712497250106, 4792.544708252711, 4836.250381190921, 4881.609471242363, 4922.975385123052, 4923.630727695366, 4990.451050384382, 5038.2190760432195, 4714.882127946828, 4766.785494652819, 4787.8563643090765, 4805.975970120127, 4809.927851082307, 4982.352294201875, 4993.248341872178, 4993.6254780892305, 4994.500549944976, 5037.420696619789, 4959.454460009469, 5056.140456122542, 5063.265826455217, 5069.797208111634, 5113.667611605234, 4834.0, 4858.3441235432765, 4862.732549709658, 4871.439784424837, 4903.31353610502, 4871.756412179448, 4874.4150701916, 4878.170710979071, 4884.0476107158765, 4922.975385123052, 4764.166270902509, 4786.234202527578, 4793.544613261734, 4804.6876952997945, 4856.0, 4783.641226908066, 4848.442429120555, 4909.091818013679, 4949.653524253267, 4969.503049695001, 4869.780859861244, 4876.609871210366, 4894.657373983787, 4903.6077113831525, 4904.386951631046], "value": 4636.508920546436, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.2885249176071, 568.6929058308514, 570.8144852922799, 574.9453801888819, 578.3753546170136, 27316.0, 29836.701632983662, 29851.701482985136, 29863.253418664543, 29876.850615746946, 29589.85205073977, 30237.0, 30303.0, 37773.811130944305, 38855.80572097136, 7580.924190758091, 7710.190430004853, 7713.34436572892, 7713.42149338799, 7716.305532502074, 7553.8866916996285, 7644.120926093487, 7645.235476452338, 7647.61761911905, 7653.31120199182, 7656.923430765704, 7668.501547399429, 7692.538447693129, 7693.49992250502, 7695.884561731578, 7595.392368610525, 7644.961775191144, 7658.119316278588, 7663.846723065563, 7664.31021208094, 7603.0, 7664.846703065908, 7669.118051424102, 7670.4247181461615, 7670.539767613961, 36067.278654426766, 36170.45744313837, 36317.455238171446, 36372.818135909154, 36399.63600363989, 2968.525035994252, 3087.1818967973504, 3243.367543329052, 3592.1738000259825, 3651.1054791576234, 26712.20600242979, 27270.5909411357, 27299.31751706223, 27306.726932730617, 27319.590206146924, 3425.2978139481597, 3492.5808902931813, 3613.9638603614153, 3696.9815150924073, 3701.8889433317045, 239042.0, 240836.0, 241957.1119299618, 242270.0, 242350.99999999822, 30096.398072038435, 48969.75515122473, 49184.0, 49192.50807491879, 49232.261516077284, 30959.0, 32860.50709239364, 32879.178020549676, 32895.177620559676, 32908.0, 11127.888721112686, 11143.33140011602, 11176.776464470666, 11180.776384472427, 11217.551297948154, 8769.824603507894, 8788.209061184523, 8828.940527136785, 8846.77883052916, 8877.866831997526, 7689.807754806175, 7724.613769311624, 7790.298873101448, 7816.257455541714, 7817.687292508236, 2993.0, 3035.2411897025745, 3049.8017628854054, 3077.7999430036975, 3112.25305926576, 804.3484777330381, 821.2239433735183, 906.727981605529, 935.4995077633433, 938.1790932933683, 25380.74619253821, 26698.733012669625, 27158.5926211107, 27258.0, 27306.45387092247, 723.5911709883899, 936.3258453913172, 936.8969413364524, 965.4014511003223, 1004.5680357446222, 13632.522861699992, 14205.573832785032, 14233.78649320261, 14489.492867749577, 14491.130532168103, 358166.0, 359993.0, 360556.0, 363925.0, 364226.0, 47898.76050619724, 48270.5172948273, 48345.27482087771, 48428.0, 48940.26589601159, 1050.5272627317738, 1077.6820837853008, 1088.4122573810055, 1135.392564977733, 1170.087331881134, 24231.30380873322, 28211.2947176314, 28486.85756571204, 28801.85599072075, 28954.855225723735, 40300.0, 40762.79618601888, 40769.0, 40794.388084178165, 40824.79587602043, 220492.0, 221354.0, 221546.0, 221601.0, 221821.0, 23951.0, 24286.63570046486, 24987.87506062458, 25011.749882500942, 26287.0, 39958.800205998785, 40188.79905600454, 40273.395899062125, 40392.596074038884, 40804.38793418042, 34721.305573887876, 34741.305173896886, 34897.65102348944, 35276.11809704778, 35283.823580882956, 34606.0, 34710.305793883475, 34787.478187826695, 34816.0, 34835.825820870734, 33742.49386259159, 34011.82994085113, 34277.65722342745, 34367.65632343745, 34597.82701086579, 30133.397332053675, 31798.682013180496, 32371.676283237808, 32393.838030809697, 32434.675653243165, 23940.640890387007, 24281.878590606935, 24755.504889902462, 25160.496790064462, 25164.49671006606], "value": 15488.76240316813, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.5419710489394, 363.9854405823767, 364.51701495518444, 376.80406188781836, 394.1820722001845, 12514.4994200232, 12577.11960162789, 13010.284434356106, 13260.204387736743, 17212.13939303033, 16091.678166436664, 16296.429624963128, 16359.91820040901, 16370.83629163708, 16489.505314840542, 4847.175980083385, 4881.633877459187, 5013.699178049311, 5042.84871453857, 5045.192769156935, 4955.132851750947, 5046.873828154307, 5050.520200580939, 5050.621203409741, 5053.216751403538, 4962.206047032476, 5315.0432922074015, 5338.252644629755, 5434.8913021739545, 5436.91844622331, 5324.973375133119, 5361.463853614647, 5370.865728356784, 5371.033214021494, 5565.526930210937, 5191.610629202787, 5208.374995000624, 5220.843374698765, 5246.501582349671, 5249.68501889884, 10330.483475826179, 10507.369557826554, 10782.514786834612, 19245.903770481058, 19422.766381866124, 1749.553863764732, 1772.7606773085597, 1953.8143876331726, 2000.669889468236, 2358.681577986984, 8862.335324850597, 8981.955090224572, 8987.550622468916, 9312.394694344846, 9434.575444105032, 1704.4375356132446, 1715.2195750933295, 1725.8015328237288, 1752.7283271093002, 1759.7704127389027, 63105.684471577806, 66981.62729658793, 67268.32731672718, 68926.0, 71178.64410677913, 9645.807083858284, 9679.661211857692, 9863.7040888772, 9956.084823548093, 10047.748806279902, 13552.186868787905, 13569.0, 13569.592912212649, 13579.59261222165, 13595.456181752817, 6554.9672251639395, 6568.737250510022, 6751.25736169021, 6772.458203343721, 6782.728690852311, 6068.120122582201, 6117.113018612276, 6211.720472578745, 6237.75048998035, 6247.219097612799, 4139.97930010348, 4187.45563076798, 4237.915241695149, 4300.65594752419, 4374.4531933508315, 1749.82501749824, 1754.333353325728, 1757.200473784425, 1795.5870149865605, 1812.6737187306412, 802.5987006496752, 838.4089217101929, 875.444093000949, 900.7477906186278, 954.8329042417549, 15621.218939053002, 16043.679126417406, 16054.919725401298, 16609.252583633766, 16675.582040604044, 792.6393490961599, 810.720301495983, 832.6794184239111, 833.2833762963846, 852.4416507187802, 8526.35682938291, 8904.421212621159, 9136.360454768235, 9267.907320926839, 9289.90710092904, 360712.0, 367518.0, 367989.0, 369693.0, 372148.0, 73369.63315183496, 73435.0, 74442.62778686071, 75893.24106758862, 76269.61865190639, 850.7447765670274, 865.8008658008567, 866.5234121233296, 867.0765634599258, 869.6695255802881, 13977.58067257984, 14031.368588413341, 14223.502177423741, 14234.14595124296, 14688.77966830477, 34669.0, 35193.82403087968, 35478.0, 35567.46648800322, 40024.0, 48943.0, 50293.0, 50596.24105638492, 50677.74661126671, 52739.0, 7210.098737657793, 7302.415806735342, 7355.411567074514, 7444.813879653052, 7456.813579660552, 9521.952390238004, 10550.449570366003, 11109.277896936674, 11180.832287515856, 11202.327860328407, 9295.256379489489, 9657.806843863224, 9947.701568952943, 10033.397996120257, 10067.949660251652, 9649.214895244402, 9736.659216927374, 9864.654737084167, 10142.391456512632, 10235.488225588542, 9510.95244523773, 9621.27840411958, 9655.179309758469, 10046.346987445793, 10173.287869849335, 7068.505204635626, 7265.527740696838, 7351.264873512606, 7407.851842963219, 7468.813279668052, 8129.4715843469985, 9833.60665573369, 9915.0, 9971.45157016371, 10242.0], "value": 7800.106264437593, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1155.3645494977761, 1292.967675808105, 1334.8798608125269, 1360.7346567419352, 1605.8956167849096, 5868.207791948091, 6610.471162307016, 6789.558678685894, 6829.078074459946, 7022.964885175567, 6891.0, 6949.44404447643, 6953.165620125579, 6955.130608673916, 6956.8956465653055, 2100.69539916712, 2108.1567373050825, 2108.725865637465, 2115.8307335413206, 2123.2674727219087, 2065.5249292662697, 2124.3626911926362, 2134.8398870084807, 2138.518833262511, 2141.389703934379, 2007.9899600501976, 2018.3541266794632, 2020.8383329333617, 2022.3427386099504, 2023.5345870449805, 2050.9794902051012, 2064.298138632857, 2072.782357852419, 2073.0360382422173, 2073.6889466579983, 2072.0779253232317, 2072.1814883121233, 2101.5271563898154, 2104.2529901884764, 2107.725995620575, 6639.435647969928, 6789.18529776425, 6842.726290948356, 6911.928651059094, 6954.061201737752, 4229.090745489703, 4358.389825424443, 4368.230866499073, 4368.301071828492, 4372.737635741865, 2664.267326485232, 2831.8725657345467, 2911.941761164786, 2912.8397938113394, 2921.1674672718386, 896.2874514760781, 907.9591418386123, 912.16536868765, 920.3741455810047, 931.2177770672599, 8587.22714955657, 8690.348223883171, 8718.694845680371, 8772.517511536927, 8783.912160878373, 3718.9070273243387, 3746.812659367021, 3799.4490798834568, 3841.769493830379, 3854.479645247912, 7154.749583764543, 7164.140303163549, 7183.784486465414, 7209.0988626421695, 7259.709611615476, 4256.233877901946, 4266.466691663542, 4266.573342665709, 4268.829246830154, 4269.466316710411, 3244.853981570835, 3343.782654127474, 3831.693464522887, 3973.304671682444, 3988.202359528106, 3112.1130477813713, 3169.35028319194, 3284.687954644305, 3292.86828526861, 3305.6281643117836, 1013.9493025348703, 1021.9131373833159, 1048.046277887119, 1053.3100818963592, 1056.1656291529605, 685.1264637587117, 716.9820754481076, 747.3460721868365, 781.8944442500303, 784.4391260248949, 4391.429114215131, 4393.538678438782, 4548.636109111263, 4549.181147393501, 4611.492735799059, 409.62110048205886, 417.49691621595906, 420.3438452497151, 421.2880232407222, 426.5585119401405, 2902.1293611916763, 2914.4608247474284, 2924.1373794730607, 2971.1383698727127, 3071.3550154467366, 7770.300672939463, 8092.3930705197345, 8150.429469937166, 8196.057453392817, 8197.754067377988, 8163.959180204061, 8167.162388462667, 8173.34613230952, 8176.264136227768, 8178.877316840252, 6298.905516417258, 6411.807645770635, 6427.871442571122, 6476.190476190476, 6483.481321494269, 4400.0, 4449.976505403711, 4511.819527219006, 4517.864464066083, 4529.705569137996, 7358.632068396666, 7594.430417718582, 7651.61741912891, 7669.769906902802, 7670.769876903479, 7743.45795794289, 7791.337736292478, 7812.101608315116, 7864.21357864209, 7865.488743231672, 5201.7399130044105, 5658.85852853682, 5755.280589926259, 5764.13537969308, 5765.0, 5995.520358371407, 6163.229596300463, 6164.352742961924, 6176.35148309421, 6178.135061091541, 5533.225348451139, 5744.454276843693, 5787.594868359174, 5830.18377427169, 5964.970175149097, 5765.682887441231, 5808.506276966336, 5826.126081087701, 5890.587658863838, 6003.249593800775, 5132.9743351283005, 5133.717645529532, 5136.589072874236, 5192.532672059533, 5206.583473322049, 3847.5960024197057, 3898.4542164096483, 3929.2730844792663, 3948.26957012942, 3982.7212095153063, 3954.822033008579, 3955.6472922712, 3965.345717956505, 3998.840046398228, 4079.0], "value": 3597.220039384104, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.6483155381989, 297.07609334968254, 304.0725786351628, 304.9313904371516, 306.7883160619171, 4793.32893394925, 4836.814980329816, 4842.104210721019, 4881.438634557027, 4896.926546101807, 4802.135615589193, 4806.279058141281, 4831.396075490564, 4845.757712114389, 4846.297286893398, 3563.608003119661, 3577.6064632890493, 3665.523481947343, 3675.7426980111404, 3730.142067324517, 3719.0888232383104, 3728.5525736911472, 3736.5516138063335, 3750.887473375803, 3751.3247615429214, 3694.963050369502, 3695.224002959382, 3706.666400023997, 3712.721545884056, 3718.4794128821986, 3541.9197144870805, 3653.451982202664, 3672.3573374659327, 3745.176061266517, 3752.6810221131236, 3310.702036816674, 3312.3706495765728, 3312.4368857294317, 3318.286568387784, 3318.568586083818, 4712.6229901607785, 4720.221163508017, 4730.881727956794, 4744.4069491313585, 4815.109204797089, 4181.707280490367, 4281.957180428187, 4292.0, 4322.200392927319, 4337.742054804103, 4982.701037937735, 4998.300577803528, 5007.272490990639, 5022.77397517109, 5038.168702164138, 3627.2020155565997, 3632.110133017428, 3638.0, 3642.7814331139953, 3645.4714066460215, 5067.822626208102, 5272.446393128743, 5278.9208161877605, 5289.259503669489, 5321.308229930123, 3595.5685317762036, 3604.2971620534267, 3610.7291953103095, 3612.512310838003, 3617.222297206061, 3642.4354225095153, 3646.3072016316814, 3648.9817550912076, 3653.7807731535663, 3653.8173091345325, 4094.467719196485, 4224.78876056196, 4226.344916537942, 4227.725197862191, 4235.30117530604, 5028.270900719375, 5050.641323519818, 5065.696058236517, 5078.908034772541, 5087.516685914832, 1218.451696736472, 1227.821965814952, 1228.9139760216879, 1235.110720281396, 1235.1971218707731, 759.1345865713091, 801.4950581133965, 839.4082172068677, 856.3985347400277, 859.9183077607618, 4160.355144952538, 4414.426124603781, 4506.662000349987, 4507.881295790973, 4533.818647254139, 5209.348831396075, 5215.269862219292, 5224.764885580158, 5225.451327610622, 5232.843014709565, 4383.802728877208, 4550.340200670884, 4559.224931761609, 4560.1335746208115, 4568.657350698711, 2652.602109683563, 2677.799165062628, 2678.772304354152, 2686.489566982267, 2689.2335684330264, 4726.456457507431, 4745.572898439157, 4749.667523273338, 4754.263089221176, 4760.738159401197, 4869.391326084239, 5132.461091585405, 5133.12736834739, 5177.275181474596, 5188.11801993662, 4718.669693121517, 4748.19280722278, 4751.809927602926, 4768.8092476301945, 4769.642276829251, 5034.471380505141, 5044.798208071783, 5059.418166910705, 5074.137396642654, 5088.745562721923, 4855.34452848875, 4924.384451943507, 4986.850394488171, 5012.824551140839, 5018.42288136869, 4858.17411040117, 4881.8535443936735, 4897.2654101885, 4910.404118661378, 4921.360223170965, 3641.7450778445254, 3659.432787917877, 3662.589902887354, 3692.8338224780487, 3721.106934335794, 5107.87230319245, 5300.997746701216, 5304.443033481429, 5306.416294207557, 5330.9733451332495, 5000.5999520037585, 5037.420696619935, 5089.465606111453, 5118.97440512795, 5140.871478212925, 5058.317127187783, 5064.265681476239, 5069.645124841226, 5097.796088156432, 5103.5661968733075, 4735.526447355237, 5021.196608542616, 5032.924506132485, 5038.899222015612, 5055.368078990126, 4877.439094504178, 4946.208606622923, 4972.204447288416, 5089.414717307557, 5116.0, 4945.19500382365, 4965.851024469272, 4986.0, 4996.075725990703, 4997.900461898376], "value": 3774.4030759028883, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.8309747916801, 648.854007848234, 651.3128649275013, 676.9999999999997, 731.9707211711532, 11811.822822657656, 12418.81371779424, 12450.315232662211, 12450.564230251943, 12494.250344979308, 11689.473973671184, 11729.824052639216, 11828.408579571009, 11834.467448964795, 11847.170698051139, 602.5631417222522, 621.4872729997747, 723.8950352198941, 727.7925791149523, 753.15270320889, 749.5689978262494, 751.943604229685, 754.7169811320755, 754.9547027178387, 755.4598462099598, 793.5040599625235, 794.6185830801219, 795.2326005404783, 795.2842441802367, 796.6375299238832, 625.0748891640352, 644.3427703742157, 782.7025730222507, 782.8864814601908, 783.0916137280784, 481.4727872979082, 481.72060205081317, 481.78560540559465, 554.2102503931922, 570.4609144358583, 12380.133390662657, 12405.069619778462, 12433.689157771038, 12451.501939922393, 12481.50073997039, 11367.261128026652, 11486.827697584544, 11690.707732306675, 11799.233049851731, 11960.70098247542, 9157.725268241897, 9408.764780880465, 10663.733406664818, 10687.251892367538, 10866.891331086666, 3988.3219852625125, 4005.9799701001307, 4080.3471444569022, 4114.0, 4248.532661407243, 45775.54224457746, 46577.040951519164, 47436.05127897457, 47597.0, 47644.047119057424, 8974.86537701935, 9584.76038099053, 9845.60617575289, 9955.303128780915, 10075.949620251999, 17474.301027958994, 17619.0, 17759.289628414976, 17813.287468501374, 17832.732509012374, 6440.516961227927, 6451.322611125858, 6595.472362211011, 6774.356436138559, 6817.625030623363, 3554.4668299755244, 3612.837422316002, 3645.3256147612246, 3683.7053035757076, 3724.478572999782, 2725.0, 2812.6202962599787, 2893.1899068260923, 3041.194083567856, 3048.481758101128, 529.3515443581658, 532.7043490862609, 535.700007995516, 536.4608568388744, 541.8211990043276, 543.4212563619732, 553.3111276460832, 574.2161948939668, 583.7781642975727, 589.9999500846111, 6469.741210351627, 6520.902186467112, 6629.569078009914, 6743.561668491532, 6835.077264569319, 496.61760444457565, 517.7152566088636, 567.7416775367197, 574.1559906936797, 574.3022227993008, 3143.7170654640736, 3148.2286839723956, 3191.0, 3302.570665813477, 3319.253168037221, 64983.0, 68225.65887170532, 68868.0, 69573.0, 70495.64752176206, 35542.64457355393, 37180.0, 43147.35278970818, 51630.48369516332, 60757.69621151866, 55749.0, 56278.0, 56916.71541642265, 58307.70846145827, 59233.40766592451, 6270.686465676789, 6444.742210311722, 6511.804645860631, 6530.542861999615, 6587.868242635216, 38156.6184338153, 38549.0, 38640.61359386483, 38757.22485550329, 39328.0, 49538.25692614542, 50473.0, 51759.74120129375, 52048.479515204366, 52347.738261309976, 8538.316934645338, 8741.169588889044, 9009.684661036832, 9031.864522032043, 9162.67930622425, 9674.129328360481, 9772.654562904994, 9965.451900145561, 10054.54754536033, 10114.8482772757, 8692.130786921258, 8826.691065812665, 8844.646214151619, 8897.199252067345, 8909.866352004854, 9367.344285900193, 9526.190273826802, 9541.427514349161, 9945.602175912882, 10064.69805905824, 7862.33170180541, 8026.518408895485, 8475.618597163018, 8574.09971952936, 8610.827783444422, 7277.963610181915, 7508.962455187689, 7575.431842611936, 7618.390528757575, 7834.921650783419, 7157.677904494206, 7265.491415600857, 7346.926530734624, 7415.443841711785, 7441.925580744123], "value": 5681.45667615415, "unit": "score"}], "name": "dromaeo_css", "value": 5923.869840798445, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 116.0, 115.0, 114.0, 118.0, 114.0, 113.0, 116.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 130.0, 130.0, 172.0, 130.0, 132.0, 127.0, 130.0, 166.0, 134.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 163.0, 161.0, 161.0, 162.0, 161.0, 162.0, 159.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 123.0, 75.0, 76.0, 76.0, 76.0, 99.0, 76.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 120.0, 84.0, 83.0, 83.0, 103.0, 83.0, 83.0, 119.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 119.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 84.0, 84.0, 84.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 67.0, 68.0, 67.0, 66.0, 67.0, 66.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 66.0, 67.0, 67.0, 68.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 87.0, 99.0, 86.0, 89.0, 83.0, 91.0, 83.0, 82.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 142.0, 147.0, 149.0, 141.0, 149.0, 140.0, 140.0, 227.0, 140.0], "value": 151.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 179.0, 175.0, 177.0, 177.0, 175.0, 176.0, 178.0, 181.0, 178.0], "value": 177.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 74.0, 69.0, 81.0, 69.0, 69.0, 70.0, 69.0, 68.0], "value": 71.2, "unit": "score"}], "name": "kraken", "value": 1561.8000000000002, "alertThreshold": 2.0}]} 15:19:55 INFO - Return code: 0 15:19:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:19:55 INFO - # TBPL SUCCESS # 15:19:55 INFO - Running post-action listener: _resource_record_post_action 15:19:55 INFO - [mozharness: 2016-11-08 23:19:55.985489Z] Finished run-tests step (success) 15:19:55 INFO - Running post-run listener: _resource_record_post_run 15:19:56 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8192; Write bytes: 404107264; Read time: 104; Write time: 246276 15:19:56 INFO - TinderboxPrint: CPU usage
13.1% 15:19:56 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 104 15:19:56 INFO - TinderboxPrint: I/O write bytes / time
404,107,264 / 246,276 15:19:56 INFO - TinderboxPrint: CPU idle
8,345.0 (86.9%) 15:19:56 INFO - TinderboxPrint: CPU user
1,205.2 (12.6%) 15:19:56 INFO - TinderboxPrint: Swap in / out
0 / 0 15:19:56 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110608384; Read time: 0; Write time: 55288 15:19:56 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293498880; Read time: 88; Write time: 190988 15:19:56 INFO - Running post-run listener: _upload_blobber_files 15:19:56 INFO - Blob upload gear active. 15:19:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:19:56 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 15:19:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:19:57 INFO - (blobuploader) - INFO - Open directory for files ... 15:19:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:19:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:20:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:20:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:20:00 INFO - (blobuploader) - INFO - Done attempting. 15:20:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:20:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:20:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:20:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:20:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:20:01 INFO - (blobuploader) - INFO - Done attempting. 15:20:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:20:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:20:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:20:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:20:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:20:02 INFO - (blobuploader) - INFO - Done attempting. 15:20:02 INFO - (blobuploader) - INFO - Iteration through files over. 15:20:02 INFO - Return code: 0 15:20:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:20:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:20:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3141d052598ac44487a33fbd28df3502e6fcd63ce370d5ce3d05f94f0f2c7f7934c1d949e44646ce080dfcf0f3a73168b0fc7d8d49dbd16d38df685f4827f0f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dea60c1179dbdd2d9dbaf5ecec10987d3d07dd4a064fc8debaeff81cc19ed3a3a8ccb6085921034370d7f72ee191aea8e7ab17ea6824ce5c9c1e6785cb63679a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b41c21cac79f2ea2df51df78a80cdf4463ac14bf0e3e62b893e14ecf61814c236b67c409a7fa1fc5909759a7b7aa121a428c9558173e6c4efaf26e84851b4e7"} 15:20:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:20:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:20:02 INFO - Contents: 15:20:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3141d052598ac44487a33fbd28df3502e6fcd63ce370d5ce3d05f94f0f2c7f7934c1d949e44646ce080dfcf0f3a73168b0fc7d8d49dbd16d38df685f4827f0f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dea60c1179dbdd2d9dbaf5ecec10987d3d07dd4a064fc8debaeff81cc19ed3a3a8ccb6085921034370d7f72ee191aea8e7ab17ea6824ce5c9c1e6785cb63679a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b41c21cac79f2ea2df51df78a80cdf4463ac14bf0e3e62b893e14ecf61814c236b67c409a7fa1fc5909759a7b7aa121a428c9558173e6c4efaf26e84851b4e7"} 15:20:02 INFO - Running post-run listener: copy_logs_to_upload_dir 15:20:02 INFO - Copying logs to upload dir... 15:20:02 INFO - mkdir: /builds/slave/test/build/upload/logs 15:20:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.249741 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-11-08 15:20:02.030699) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 15:20:02.034870) ========= 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=1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3141d052598ac44487a33fbd28df3502e6fcd63ce370d5ce3d05f94f0f2c7f7934c1d949e44646ce080dfcf0f3a73168b0fc7d8d49dbd16d38df685f4827f0f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dea60c1179dbdd2d9dbaf5ecec10987d3d07dd4a064fc8debaeff81cc19ed3a3a8ccb6085921034370d7f72ee191aea8e7ab17ea6824ce5c9c1e6785cb63679a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b41c21cac79f2ea2df51df78a80cdf4463ac14bf0e3e62b893e14ecf61814c236b67c409a7fa1fc5909759a7b7aa121a428c9558173e6c4efaf26e84851b4e7"} build_url:https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011187 build_url: 'https://queue.taskcluster.net/v1/task/bMmJbXSZS2qfHRs_EjndNw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3141d052598ac44487a33fbd28df3502e6fcd63ce370d5ce3d05f94f0f2c7f7934c1d949e44646ce080dfcf0f3a73168b0fc7d8d49dbd16d38df685f4827f0f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dea60c1179dbdd2d9dbaf5ecec10987d3d07dd4a064fc8debaeff81cc19ed3a3a8ccb6085921034370d7f72ee191aea8e7ab17ea6824ce5c9c1e6785cb63679a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b41c21cac79f2ea2df51df78a80cdf4463ac14bf0e3e62b893e14ecf61814c236b67c409a7fa1fc5909759a7b7aa121a428c9558173e6c4efaf26e84851b4e7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 15:20:02.064597) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 15:20:02.064922) ========= 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=1f5564757af27664ca02d71f000001b0-1478644545.697397-58117051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 15:20:02.147918) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 15:20:02.148242) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 15:20:02.148525) ========= ========= Total master_lag: 0.35 =========