builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1477596658.64 results: success (0) buildid: 20161027122243 builduid: 247dc5f4f49441f199996cc19ff6b296 revision: 9888f1a23001fde6435e1a9ed7e6d3af8dd988d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 12:30:58.643915) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 12:30:58.644395) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 12:30:58.644687) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 12:30:58.662405) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 12:30:58.662790) ========= 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=5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-27 12:30:58-- 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% 46.0M=0s 2016-10-27 12:30:59 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.143170 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 12:30:58.819861) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 12:30:58.820205) ========= 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=5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018095 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 12:30:58.873272) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 12:30:58.876811) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9888f1a23001fde6435e1a9ed7e6d3af8dd988d8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 9888f1a23001fde6435e1a9ed7e6d3af8dd988d8 --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=5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-27 12:30:59,255 truncating revision to first 12 chars 2016-10-27 12:30:59,255 Setting DEBUG logging. 2016-10-27 12:30:59,255 attempt 1/10 2016-10-27 12:30:59,255 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9888f1a23001?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-27 12:30:59,562 unpacking tar archive at: fx-team-9888f1a23001/testing/mozharness/ program finished with exit code 0 elapsedTime=0.625853 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 12:30:59.519715) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 12:30:59.520113) ========= script_repo_revision: 9888f1a23001fde6435e1a9ed7e6d3af8dd988d8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 12:30:59.520569) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 12:30:59.520845) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 12:30:59.531824) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-27 12:30:59.532226) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:30:59 INFO - MultiFileLogger online at 20161027 12:30:59 in /builds/slave/test 12:30:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:30:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:31:00 INFO - {'append_to_log': False, 12:31:00 INFO - 'base_work_dir': '/builds/slave/test', 12:31:00 INFO - 'blob_upload_branch': 'Fx-Team', 12:31:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:31:00 INFO - 'branch': 'Fx-Team', 12:31:00 INFO - 'buildbot_json_path': 'buildprops.json', 12:31:00 INFO - 'config_files': ('talos/linux_config.py',), 12:31:00 INFO - 'default_actions': ('clobber', 12:31:00 INFO - 'read-buildbot-config', 12:31:00 INFO - 'download-and-extract', 12:31:00 INFO - 'populate-webroot', 12:31:00 INFO - 'create-virtualenv', 12:31:00 INFO - 'install', 12:31:00 INFO - 'run-tests'), 12:31:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:31:00 INFO - 'download_minidump_stackwalk': True, 12:31:00 INFO - 'download_symbols': 'ondemand', 12:31:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:31:00 INFO - 'tooltool.py': '/tools/tooltool.py', 12:31:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:31:00 INFO - '/tools/misc-python/virtualenv.py')}, 12:31:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:31:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:31:00 INFO - 'installer_path': 'installer.exe', 12:31:00 INFO - 'log_level': 'info', 12:31:00 INFO - 'log_name': 'talos', 12:31:00 INFO - 'log_to_console': True, 12:31:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:31:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:31:00 INFO - 'opt_config_files': (), 12:31:00 INFO - 'pip_index': False, 12:31:00 INFO - 'sps_profile': False, 12:31:00 INFO - 'sps_profile_interval': 0, 12:31:00 INFO - 'suite': 'dromaeojs-e10s', 12:31:00 INFO - 'system_bits': '32', 12:31:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:31:00 INFO - 'title': 'talos-linux64-ix-039', 12:31:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:31:00 INFO - 'use_talos_json': True, 12:31:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:31:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:31:00 INFO - 'work_dir': 'build'} 12:31:00 INFO - [mozharness: 2016-10-27 19:31:00.006135Z] Running clobber step. 12:31:00 INFO - Running pre-action listener: _resource_record_pre_action 12:31:00 INFO - Running main action method: clobber 12:31:00 INFO - rmtree: /builds/slave/test/build 12:31:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:31:00 INFO - Running post-action listener: _resource_record_post_action 12:31:00 INFO - [mozharness: 2016-10-27 19:31:00.474491Z] Finished clobber step (success) 12:31:00 INFO - [mozharness: 2016-10-27 19:31:00.474592Z] Running read-buildbot-config step. 12:31:00 INFO - Running pre-action listener: _resource_record_pre_action 12:31:00 INFO - Running main action method: read_buildbot_config 12:31:00 INFO - Using buildbot properties: 12:31:00 INFO - { 12:31:00 INFO - "project": "", 12:31:00 INFO - "product": "firefox", 12:31:00 INFO - "script_repo_revision": "production", 12:31:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:31:00 INFO - "repository": "", 12:31:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 12:31:00 INFO - "buildid": "20161027122243", 12:31:00 INFO - "stage_platform": "linux64-pgo", 12:31:00 INFO - "basedir": "/builds/slave/test", 12:31:00 INFO - "buildnumber": 851, 12:31:00 INFO - "platform": "ubuntu64_hw", 12:31:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:31:00 INFO - "slavebuilddir": "test", 12:31:00 INFO - "branch": "fx-team", 12:31:00 INFO - "revision": "9888f1a23001fde6435e1a9ed7e6d3af8dd988d8", 12:31:00 INFO - "slavename": "talos-linux64-ix-039", 12:31:00 INFO - "builduid": "247dc5f4f49441f199996cc19ff6b296", 12:31:00 INFO - "repo_path": "integration/fx-team" 12:31:00 INFO - } 12:31:00 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:31:00 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 12:31:00 INFO - Running post-action listener: _resource_record_post_action 12:31:00 INFO - [mozharness: 2016-10-27 19:31:00.476938Z] Finished read-buildbot-config step (success) 12:31:00 INFO - [mozharness: 2016-10-27 19:31:00.477025Z] Running download-and-extract step. 12:31:00 INFO - Running pre-action listener: _resource_record_pre_action 12:31:00 INFO - Running main action method: download_and_extract 12:31:00 INFO - mkdir: /builds/slave/test/build/tests 12:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:00 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:31:00 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/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 12:31:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/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 12:31:00 INFO - Downloaded 1361 bytes. 12:31:00 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:31:00 INFO - Using the following test package requirements: 12:31:00 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:31:00 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:31:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:31:00 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:31:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:31:00 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:31:00 INFO - u'jsshell-linux-x86_64.zip'], 12:31:00 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:31:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:31:00 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:31:00 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:31:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:31:00 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:31:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:31:00 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:31:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:31:00 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:31:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:31:00 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:31:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:31:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:31:00 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:31:00 INFO - Http code: 200 12:31:00 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 12:31:00 INFO - x-amz-cf-id: GQFzHeTxE10EkxNf831zR08tgcqo0BLaMimntpDK-7qGvHqIGfRSUg== 12:31:00 INFO - x-amz-replication-status: COMPLETED 12:31:00 INFO - x-amz-version-id: _5aEyNhGvxivC4Ty3jvtkVjUnNpdEVgd 12:31:00 INFO - Expected file size: 21992409 12:31:00 INFO - Obtained file size: 21992409 12:31:04 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 12:31:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:31:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:31:04 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:31:04 INFO - Http code: 200 12:31:04 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 12:31:04 INFO - x-amz-cf-id: 2oVNDfrJB4eKIWRGk7Tnun9-1JOlxmK0cgjlND30P-plwtoYW6sOXw== 12:31:04 INFO - x-amz-replication-status: COMPLETED 12:31:04 INFO - x-amz-version-id: _5aEyNhGvxivC4Ty3jvtkVjUnNpdEVgd 12:31:05 INFO - Expected file size: 21992409 12:31:05 INFO - Obtained file size: 21992409 12:31:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:31:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:31:09 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:31:09 INFO - Http code: 200 12:31:09 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 12:31:09 INFO - x-amz-cf-id: lQfBpCVr72slmxujYGIr3w7KgjvTjpZNMvq6P8NAlL2BRFa2juOS4g== 12:31:09 INFO - x-amz-replication-status: COMPLETED 12:31:09 INFO - x-amz-version-id: NLE.dG4iaRuRV5o0nmCpr1hOOTopU2Vq 12:31:10 INFO - Expected file size: 14409028 12:31:10 INFO - Obtained file size: 14409028 12:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:10 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:31:10 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/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 12:31:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/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 12:31:10 INFO - Downloaded 59366763 bytes. 12:31:10 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:31:10 INFO - mkdir: /builds/slave/test/properties 12:31:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:31:10 INFO - Writing to file /builds/slave/test/properties/build_url 12:31:10 INFO - Contents: 12:31:10 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:31:11 INFO - Running post-action listener: _resource_record_post_action 12:31:11 INFO - Running post-action listener: set_extra_try_arguments 12:31:11 INFO - [mozharness: 2016-10-27 19:31:11.280574Z] Finished download-and-extract step (success) 12:31:11 INFO - [mozharness: 2016-10-27 19:31:11.280801Z] Running populate-webroot step. 12:31:11 INFO - Running pre-action listener: _resource_record_pre_action 12:31:11 INFO - Running main action method: populate_webroot 12:31:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:31:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:31:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:31:11 INFO - '--tppagecycles', 12:31:11 INFO - '7'], 12:31:11 INFO - 'tests': ['tsvgm']}}, 12:31:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:31:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:31:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:31:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:31:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:31:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:31:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:11 INFO - 'talos_options': ['--disable-e10s'], 12:31:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:31:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:31:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:11 INFO - 'talos_options': ['--disable-e10s'], 12:31:11 INFO - 'tests': ['damp', 'tps']}, 12:31:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:11 INFO - 'tests': ['damp', 'tps']}, 12:31:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:31:11 INFO - 'tests': ['dromaeo_dom']}, 12:31:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:31:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:31:11 INFO - 'tests': ['basic_compositor_video']}, 12:31:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:31:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:31:11 INFO - 'tests': ['a11yr', 12:31:11 INFO - 'ts_paint', 12:31:11 INFO - 'tpaint', 12:31:11 INFO - 'sessionrestore', 12:31:11 INFO - 'sessionrestore_no_auto_restore', 12:31:11 INFO - 'tabpaint']}, 12:31:11 INFO - 'other-e10s': {'tests': ['a11yr', 12:31:11 INFO - 'ts_paint', 12:31:11 INFO - 'tpaint', 12:31:11 INFO - 'sessionrestore', 12:31:11 INFO - 'sessionrestore_no_auto_restore', 12:31:11 INFO - 'tabpaint']}, 12:31:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:31:11 INFO - 'ts_paint', 12:31:11 INFO - 'tpaint', 12:31:11 INFO - 'sessionrestore', 12:31:11 INFO - 'sessionrestore_no_auto_restore', 12:31:11 INFO - 'tabpaint']}, 12:31:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:31:11 INFO - 'ts_paint', 12:31:11 INFO - 'tpaint', 12:31:11 INFO - 'sessionrestore', 12:31:11 INFO - 'sessionrestore_no_auto_restore', 12:31:11 INFO - 'tabpaint']}, 12:31:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:31:11 INFO - 'tests': ['a11yr', 12:31:11 INFO - 'ts_paint', 12:31:11 INFO - 'tpaint', 12:31:11 INFO - 'sessionrestore', 12:31:11 INFO - 'sessionrestore_no_auto_restore', 12:31:11 INFO - 'tabpaint']}, 12:31:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:31:11 INFO - 'tests': ['a11yr', 12:31:11 INFO - 'ts_paint', 12:31:11 INFO - 'tpaint', 12:31:11 INFO - 'sessionrestore', 12:31:11 INFO - 'sessionrestore_no_auto_restore', 12:31:11 INFO - 'tabpaint']}, 12:31:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:31:11 INFO - 'tests': ['tsvgx', 12:31:11 INFO - 'tsvgr_opacity', 12:31:11 INFO - 'tart', 12:31:11 INFO - 'tscrollx', 12:31:11 INFO - 'cart']}, 12:31:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:31:11 INFO - 'tsvgr_opacity', 12:31:11 INFO - 'tart', 12:31:11 INFO - 'tscrollx', 12:31:11 INFO - 'cart']}, 12:31:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:11 INFO - 'talos_options': ['--disable-e10s'], 12:31:11 INFO - 'tests': ['tp5o']}, 12:31:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:11 INFO - 'tests': ['tp5o']}, 12:31:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:11 INFO - 'talos_options': ['--disable-e10s', 12:31:11 INFO - '--xperf_path', 12:31:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:31:11 INFO - 'tests': ['tp5n']}, 12:31:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:11 INFO - 'talos_options': ['--xperf_path', 12:31:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:31:11 INFO - 'tests': ['tp5n']}}, 12:31:11 INFO - 'talos.zip': {'path': '', 12:31:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:31:11 INFO - Running post-action listener: _resource_record_post_action 12:31:11 INFO - [mozharness: 2016-10-27 19:31:11.302380Z] Finished populate-webroot step (success) 12:31:11 INFO - [mozharness: 2016-10-27 19:31:11.302469Z] Running create-virtualenv step. 12:31:11 INFO - Running pre-action listener: _resource_record_pre_action 12:31:11 INFO - Running main action method: create_virtualenv 12:31:11 INFO - Creating virtualenv /builds/slave/test/build/venv 12:31:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:31:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:31:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:31:11 INFO - Using real prefix '/usr' 12:31:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:31:11 INFO - Installing distribute.............................................................................................................................................................................................done. 12:31:13 INFO - Installing pip.................done. 12:31:13 INFO - Return code: 0 12:31:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:31:14 INFO - Reading from file tmpfile_stdout 12:31:14 INFO - Output received: 12:31:14 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:31:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:14 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 0x7fead25d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e05790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02930>, '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 0x1e03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e03cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:31:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:31:14 INFO - Using env: {'DISPLAY': ':0', 12:31:14 INFO - 'HOME': '/home/cltbld', 12:31:14 INFO - 'LANG': 'en_US.UTF-8', 12:31:14 INFO - 'LANGUAGE': 'en_US:en', 12:31:14 INFO - 'LOGNAME': 'cltbld', 12:31:14 INFO - 'MAIL': '/var/mail/cltbld', 12:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:14 INFO - 'MOZ_NO_REMOTE': '1', 12:31:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:14 INFO - 'NO_EM_RESTART': '1', 12:31:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:14 INFO - 'PWD': '/builds/slave/test', 12:31:14 INFO - 'SHELL': '/bin/bash', 12:31:14 INFO - 'SHLVL': '1', 12:31:14 INFO - 'TERM': 'linux', 12:31:14 INFO - 'TMOUT': '86400', 12:31:14 INFO - 'USER': 'cltbld', 12:31:14 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068', 12:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:14 INFO - '_': '/tools/buildbot/bin/python'} 12:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:31:14 INFO - Cleaning up... 12:31:14 INFO - Return code: 0 12:31:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:14 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 0x7fead25d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e05790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02930>, '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 0x1e03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e03cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:31:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:31:14 INFO - Using env: {'DISPLAY': ':0', 12:31:14 INFO - 'HOME': '/home/cltbld', 12:31:14 INFO - 'LANG': 'en_US.UTF-8', 12:31:14 INFO - 'LANGUAGE': 'en_US:en', 12:31:14 INFO - 'LOGNAME': 'cltbld', 12:31:14 INFO - 'MAIL': '/var/mail/cltbld', 12:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:14 INFO - 'MOZ_NO_REMOTE': '1', 12:31:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:14 INFO - 'NO_EM_RESTART': '1', 12:31:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:14 INFO - 'PWD': '/builds/slave/test', 12:31:14 INFO - 'SHELL': '/bin/bash', 12:31:14 INFO - 'SHLVL': '1', 12:31:14 INFO - 'TERM': 'linux', 12:31:14 INFO - 'TMOUT': '86400', 12:31:14 INFO - 'USER': 'cltbld', 12:31:14 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068', 12:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:14 INFO - '_': '/tools/buildbot/bin/python'} 12:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:14 INFO - Downloading/unpacking psutil>=3.1.1 12:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:31:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:31:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:31:16 INFO - Installing collected packages: psutil 12:31:16 INFO - Running setup.py install for psutil 12:31:16 INFO - building 'psutil._psutil_linux' extension 12:31:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:31:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:31:16 INFO - building 'psutil._psutil_posix' extension 12:31:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:31:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:31:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:31:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:31:17 INFO - Successfully installed psutil 12:31:17 INFO - Cleaning up... 12:31:17 INFO - Return code: 0 12:31:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:17 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 0x7fead25d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e05790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02930>, '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 0x1e03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e03cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:31:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:31:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:31:17 INFO - Using env: {'DISPLAY': ':0', 12:31:17 INFO - 'HOME': '/home/cltbld', 12:31:17 INFO - 'LANG': 'en_US.UTF-8', 12:31:17 INFO - 'LANGUAGE': 'en_US:en', 12:31:17 INFO - 'LOGNAME': 'cltbld', 12:31:17 INFO - 'MAIL': '/var/mail/cltbld', 12:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:17 INFO - 'MOZ_NO_REMOTE': '1', 12:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:17 INFO - 'NO_EM_RESTART': '1', 12:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:17 INFO - 'PWD': '/builds/slave/test', 12:31:17 INFO - 'SHELL': '/bin/bash', 12:31:17 INFO - 'SHLVL': '1', 12:31:17 INFO - 'TERM': 'linux', 12:31:17 INFO - 'TMOUT': '86400', 12:31:17 INFO - 'USER': 'cltbld', 12:31:17 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068', 12:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:17 INFO - '_': '/tools/buildbot/bin/python'} 12:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:31:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:31:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:31:19 INFO - Installing collected packages: mozsystemmonitor 12:31:19 INFO - Running setup.py install for mozsystemmonitor 12:31:19 INFO - Successfully installed mozsystemmonitor 12:31:19 INFO - Cleaning up... 12:31:19 INFO - Return code: 0 12:31:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fead25d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e05790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02930>, '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 0x1e03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e03cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:31:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:31:19 INFO - Using env: {'DISPLAY': ':0', 12:31:19 INFO - 'HOME': '/home/cltbld', 12:31:19 INFO - 'LANG': 'en_US.UTF-8', 12:31:19 INFO - 'LANGUAGE': 'en_US:en', 12:31:19 INFO - 'LOGNAME': 'cltbld', 12:31:19 INFO - 'MAIL': '/var/mail/cltbld', 12:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:19 INFO - 'MOZ_NO_REMOTE': '1', 12:31:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:19 INFO - 'NO_EM_RESTART': '1', 12:31:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:19 INFO - 'PWD': '/builds/slave/test', 12:31:19 INFO - 'SHELL': '/bin/bash', 12:31:19 INFO - 'SHLVL': '1', 12:31:19 INFO - 'TERM': 'linux', 12:31:19 INFO - 'TMOUT': '86400', 12:31:19 INFO - 'USER': 'cltbld', 12:31:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068', 12:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:19 INFO - '_': '/tools/buildbot/bin/python'} 12:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:19 INFO - Downloading/unpacking jsonschema==2.5.1 12:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:31:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:21 INFO - Downloading functools32-3.2.3-2.tar.gz 12:31:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:31:21 INFO - warning: no files found matching '*.txt' 12:31:21 INFO - no previously-included directories found matching 'build' 12:31:21 INFO - no previously-included directories found matching 'dist' 12:31:21 INFO - no previously-included directories found matching '.git*' 12:31:21 INFO - Installing collected packages: jsonschema, functools32 12:31:21 INFO - Running setup.py install for functools32 12:31:22 INFO - warning: no files found matching '*.txt' 12:31:22 INFO - no previously-included directories found matching 'build' 12:31:22 INFO - no previously-included directories found matching 'dist' 12:31:22 INFO - no previously-included directories found matching '.git*' 12:31:22 INFO - Successfully installed jsonschema functools32 12:31:22 INFO - Cleaning up... 12:31:22 INFO - Return code: 0 12:31:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fead25d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e05790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02930>, '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 0x1e03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e03cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:31:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:31:22 INFO - Using env: {'DISPLAY': ':0', 12:31:22 INFO - 'HOME': '/home/cltbld', 12:31:22 INFO - 'LANG': 'en_US.UTF-8', 12:31:22 INFO - 'LANGUAGE': 'en_US:en', 12:31:22 INFO - 'LOGNAME': 'cltbld', 12:31:22 INFO - 'MAIL': '/var/mail/cltbld', 12:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:22 INFO - 'MOZ_NO_REMOTE': '1', 12:31:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:22 INFO - 'NO_EM_RESTART': '1', 12:31:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:22 INFO - 'PWD': '/builds/slave/test', 12:31:22 INFO - 'SHELL': '/bin/bash', 12:31:22 INFO - 'SHLVL': '1', 12:31:22 INFO - 'TERM': 'linux', 12:31:22 INFO - 'TMOUT': '86400', 12:31:22 INFO - 'USER': 'cltbld', 12:31:22 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068', 12:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:22 INFO - '_': '/tools/buildbot/bin/python'} 12:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:31:22 INFO - Cleaning up... 12:31:22 INFO - Return code: 0 12:31:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fead25d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e05790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02930>, '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 0x1e03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e03cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:31:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:31:22 INFO - Using env: {'DISPLAY': ':0', 12:31:22 INFO - 'HOME': '/home/cltbld', 12:31:22 INFO - 'LANG': 'en_US.UTF-8', 12:31:22 INFO - 'LANGUAGE': 'en_US:en', 12:31:22 INFO - 'LOGNAME': 'cltbld', 12:31:22 INFO - 'MAIL': '/var/mail/cltbld', 12:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:22 INFO - 'MOZ_NO_REMOTE': '1', 12:31:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:22 INFO - 'NO_EM_RESTART': '1', 12:31:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:22 INFO - 'PWD': '/builds/slave/test', 12:31:22 INFO - 'SHELL': '/bin/bash', 12:31:22 INFO - 'SHLVL': '1', 12:31:22 INFO - 'TERM': 'linux', 12:31:22 INFO - 'TMOUT': '86400', 12:31:22 INFO - 'USER': 'cltbld', 12:31:22 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068', 12:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:22 INFO - '_': '/tools/buildbot/bin/python'} 12:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:22 INFO - Downloading/unpacking blobuploader==1.2.4 12:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:24 INFO - Downloading blobuploader-1.2.4.tar.gz 12:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:31:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:31:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:25 INFO - Downloading docopt-0.6.1.tar.gz 12:31:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:31:25 INFO - Installing collected packages: blobuploader, requests, docopt 12:31:25 INFO - Running setup.py install for blobuploader 12:31:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:31:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:31:25 INFO - Running setup.py install for requests 12:31:25 INFO - Running setup.py install for docopt 12:31:25 INFO - Successfully installed blobuploader requests docopt 12:31:25 INFO - Cleaning up... 12:31:25 INFO - Return code: 0 12:31:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:25 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 0x7fead25d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e05790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02930>, '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 0x1e03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e03cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:31:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:31:25 INFO - Using env: {'DISPLAY': ':0', 12:31:25 INFO - 'HOME': '/home/cltbld', 12:31:25 INFO - 'LANG': 'en_US.UTF-8', 12:31:25 INFO - 'LANGUAGE': 'en_US:en', 12:31:25 INFO - 'LOGNAME': 'cltbld', 12:31:25 INFO - 'MAIL': '/var/mail/cltbld', 12:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:25 INFO - 'MOZ_NO_REMOTE': '1', 12:31:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:25 INFO - 'NO_EM_RESTART': '1', 12:31:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:25 INFO - 'PWD': '/builds/slave/test', 12:31:25 INFO - 'SHELL': '/bin/bash', 12:31:25 INFO - 'SHLVL': '1', 12:31:25 INFO - 'TERM': 'linux', 12:31:25 INFO - 'TMOUT': '86400', 12:31:25 INFO - 'USER': 'cltbld', 12:31:25 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068', 12:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:25 INFO - '_': '/tools/buildbot/bin/python'} 12:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:31:26 INFO - Running setup.py (path:/tmp/pip-2yeuEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:31:26 INFO - Running setup.py (path:/tmp/pip-by0FJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:31:26 INFO - Running setup.py (path:/tmp/pip-onZhbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:31:26 INFO - Running setup.py (path:/tmp/pip-By0bT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:31:26 INFO - Running setup.py (path:/tmp/pip-v2uvDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:31:26 INFO - Running setup.py (path:/tmp/pip-gbQtsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:31:26 INFO - Running setup.py (path:/tmp/pip-1DjxSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:31:26 INFO - Running setup.py (path:/tmp/pip-J3hKkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:31:26 INFO - Running setup.py (path:/tmp/pip-ZAr94Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:31:26 INFO - Running setup.py (path:/tmp/pip-Wdm3Fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:31:26 INFO - Running setup.py (path:/tmp/pip-CsYduK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:31:26 INFO - Running setup.py (path:/tmp/pip-vQJIzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:31:26 INFO - Running setup.py (path:/tmp/pip-0kmtmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:31:27 INFO - Running setup.py (path:/tmp/pip-4gCOfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:27 INFO - Running setup.py (path:/tmp/pip-ImevU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:31:27 INFO - Running setup.py (path:/tmp/pip-Ngi1Vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:31:27 INFO - Running setup.py (path:/tmp/pip-l6o53C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:31:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:31:27 INFO - Running setup.py install for manifestparser 12:31:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:31:27 INFO - Running setup.py install for mozcrash 12:31:27 INFO - Running setup.py install for mozdebug 12:31:27 INFO - Running setup.py install for mozdevice 12:31:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:31:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:31:27 INFO - Running setup.py install for mozfile 12:31:27 INFO - Running setup.py install for mozhttpd 12:31:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:31:27 INFO - Running setup.py install for mozinfo 12:31:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:31:28 INFO - Running setup.py install for mozInstall 12:31:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:31:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:31:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:31:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:31:28 INFO - Running setup.py install for mozleak 12:31:28 INFO - Running setup.py install for mozlog 12:31:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:31:28 INFO - Running setup.py install for moznetwork 12:31:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:31:28 INFO - Running setup.py install for mozprocess 12:31:28 INFO - Running setup.py install for mozprofile 12:31:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:31:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:31:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:31:28 INFO - Running setup.py install for mozrunner 12:31:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:31:28 INFO - Running setup.py install for mozscreenshot 12:31:28 INFO - Running setup.py install for moztest 12:31:28 INFO - Running setup.py install for mozversion 12:31:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:31:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:31:29 INFO - Cleaning up... 12:31:29 INFO - Return code: 0 12:31:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:29 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 0x7fead25d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e05790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02930>, '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 0x1e03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e03cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:31:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:31:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:31:29 INFO - Using env: {'DISPLAY': ':0', 12:31:29 INFO - 'HOME': '/home/cltbld', 12:31:29 INFO - 'LANG': 'en_US.UTF-8', 12:31:29 INFO - 'LANGUAGE': 'en_US:en', 12:31:29 INFO - 'LOGNAME': 'cltbld', 12:31:29 INFO - 'MAIL': '/var/mail/cltbld', 12:31:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:29 INFO - 'MOZ_NO_REMOTE': '1', 12:31:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:29 INFO - 'NO_EM_RESTART': '1', 12:31:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:29 INFO - 'PWD': '/builds/slave/test', 12:31:29 INFO - 'SHELL': '/bin/bash', 12:31:29 INFO - 'SHLVL': '1', 12:31:29 INFO - 'TERM': 'linux', 12:31:29 INFO - 'TMOUT': '86400', 12:31:29 INFO - 'USER': 'cltbld', 12:31:29 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068', 12:31:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:29 INFO - '_': '/tools/buildbot/bin/python'} 12:31:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:31:29 INFO - Running setup.py (path:/tmp/pip-3rpV40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:31:29 INFO - Running setup.py (path:/tmp/pip-WYbO0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:31:29 INFO - Running setup.py (path:/tmp/pip-5QsDly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:31:29 INFO - Running setup.py (path:/tmp/pip-k6k1hE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:31:29 INFO - Running setup.py (path:/tmp/pip-u6Jkq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:31:29 INFO - Running setup.py (path:/tmp/pip-hkSD0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:31:29 INFO - Running setup.py (path:/tmp/pip-7JBrWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:31:29 INFO - Running setup.py (path:/tmp/pip-ZdCekR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:31:29 INFO - Running setup.py (path:/tmp/pip-LK33mU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:31:29 INFO - Running setup.py (path:/tmp/pip-LnWHg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:31:30 INFO - Running setup.py (path:/tmp/pip-g1wIAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:31:30 INFO - Running setup.py (path:/tmp/pip-a4NnVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:31:30 INFO - Running setup.py (path:/tmp/pip-gIcnmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:31:30 INFO - Running setup.py (path:/tmp/pip-ngmxNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:30 INFO - Running setup.py (path:/tmp/pip-QH1NkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:31:30 INFO - Running setup.py (path:/tmp/pip-jfjUVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:31:30 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)) 12:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:31:30 INFO - Running setup.py (path:/tmp/pip-DfjmyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:31:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:32 INFO - Downloading blessings-1.6.tar.gz 12:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:31:32 INFO - Installing collected packages: blessings 12:31:32 INFO - Running setup.py install for blessings 12:31:32 INFO - Successfully installed blessings 12:31:32 INFO - Cleaning up... 12:31:32 INFO - Return code: 0 12:31:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:31:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:31:32 INFO - Reading from file tmpfile_stdout 12:31:32 INFO - Current package versions: 12:31:32 INFO - argparse == 1.2.1 12:31:32 INFO - blessings == 1.6 12:31:32 INFO - blobuploader == 1.2.4 12:31:32 INFO - docopt == 0.6.1 12:31:32 INFO - functools32 == 3.2.3-2 12:31:32 INFO - jsonschema == 2.5.1 12:31:32 INFO - manifestparser == 1.1 12:31:32 INFO - mozInstall == 1.12 12:31:32 INFO - mozcrash == 0.17 12:31:32 INFO - mozdebug == 0.1 12:31:32 INFO - mozdevice == 0.48 12:31:32 INFO - mozfile == 1.2 12:31:32 INFO - mozhttpd == 0.7 12:31:32 INFO - mozinfo == 0.9 12:31:32 INFO - mozleak == 0.1 12:31:32 INFO - mozlog == 3.4 12:31:32 INFO - moznetwork == 0.27 12:31:32 INFO - mozprocess == 0.23 12:31:32 INFO - mozprofile == 0.28 12:31:33 INFO - mozrunner == 6.12 12:31:33 INFO - mozscreenshot == 0.1 12:31:33 INFO - mozsystemmonitor == 0.3 12:31:33 INFO - moztest == 0.7 12:31:33 INFO - mozversion == 1.4 12:31:33 INFO - psutil == 3.1.1 12:31:33 INFO - requests == 1.2.3 12:31:33 INFO - wsgiref == 0.1.2 12:31:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:31: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')]} 12:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31: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')]} 12:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:33 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 0x7fead25d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e05790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02930>, '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 0x1e03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e03cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:31:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:31:33 INFO - Using env: {'DISPLAY': ':0', 12:31:33 INFO - 'HOME': '/home/cltbld', 12:31:33 INFO - 'LANG': 'en_US.UTF-8', 12:31:33 INFO - 'LANGUAGE': 'en_US:en', 12:31:33 INFO - 'LOGNAME': 'cltbld', 12:31:33 INFO - 'MAIL': '/var/mail/cltbld', 12:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:33 INFO - 'MOZ_NO_REMOTE': '1', 12:31:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:33 INFO - 'NO_EM_RESTART': '1', 12:31:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:33 INFO - 'PWD': '/builds/slave/test', 12:31:33 INFO - 'SHELL': '/bin/bash', 12:31:33 INFO - 'SHLVL': '1', 12:31:33 INFO - 'TERM': 'linux', 12:31:33 INFO - 'TMOUT': '86400', 12:31:33 INFO - 'USER': 'cltbld', 12:31:33 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068', 12:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:33 INFO - '_': '/tools/buildbot/bin/python'} 12:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:31:33 INFO - Cleaning up... 12:31:33 INFO - Return code: 0 12:31:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:31: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')]} 12:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31: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')]} 12:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fead25d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e05790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02930>, '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 0x1e03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e03cc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:31: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', 'jsonschema'] in /builds/slave/test/build 12:31: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 jsonschema 12:31:33 INFO - Using env: {'DISPLAY': ':0', 12:31:33 INFO - 'HOME': '/home/cltbld', 12:31:33 INFO - 'LANG': 'en_US.UTF-8', 12:31:33 INFO - 'LANGUAGE': 'en_US:en', 12:31:33 INFO - 'LOGNAME': 'cltbld', 12:31:33 INFO - 'MAIL': '/var/mail/cltbld', 12:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:33 INFO - 'MOZ_NO_REMOTE': '1', 12:31:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:33 INFO - 'NO_EM_RESTART': '1', 12:31:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:33 INFO - 'PWD': '/builds/slave/test', 12:31:33 INFO - 'SHELL': '/bin/bash', 12:31:33 INFO - 'SHLVL': '1', 12:31:33 INFO - 'TERM': 'linux', 12:31:33 INFO - 'TMOUT': '86400', 12:31:33 INFO - 'USER': 'cltbld', 12:31:33 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068', 12:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:33 INFO - '_': '/tools/buildbot/bin/python'} 12:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:31:33 INFO - Cleaning up... 12:31:33 INFO - Return code: 0 12:31:33 INFO - Running post-action listener: _resource_record_post_action 12:31:33 INFO - Running post-action listener: _start_resource_monitoring 12:31:33 INFO - Starting resource monitoring. 12:31:33 INFO - [mozharness: 2016-10-27 19:31:33.509606Z] Finished create-virtualenv step (success) 12:31:33 INFO - [mozharness: 2016-10-27 19:31:33.510175Z] Running install step. 12:31:33 INFO - Running pre-action listener: _resource_record_pre_action 12:31:33 INFO - Running main action method: install 12:31:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:31:33 INFO - Reading from file tmpfile_stdout 12:31:33 INFO - Detecting whether we're running mozinstall >=1.0... 12:31:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:31:33 INFO - Reading from file tmpfile_stdout 12:31:33 INFO - Output received: 12:31:33 INFO - Usage: mozinstall [options] installer 12:31:33 INFO - Options: 12:31:33 INFO - -h, --help show this help message and exit 12:31:33 INFO - -d DEST, --destination=DEST 12:31:33 INFO - Directory to install application into. [default: 12:31:33 INFO - "/builds/slave/test"] 12:31:33 INFO - --app=APP Application being installed. [default: firefox] 12:31:33 INFO - mkdir: /builds/slave/test/build/application 12:31:33 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'] 12:31:33 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 12:31:50 INFO - Reading from file tmpfile_stdout 12:31:50 INFO - Output received: 12:31:50 INFO - /builds/slave/test/build/application/firefox/firefox 12:31:50 INFO - Running post-action listener: _resource_record_post_action 12:31:50 INFO - [mozharness: 2016-10-27 19:31:50.662072Z] Finished install step (success) 12:31:50 INFO - [mozharness: 2016-10-27 19:31:50.662346Z] Running run-tests step. 12:31:50 INFO - Running pre-action listener: _resource_record_pre_action 12:31:50 INFO - Running main action method: run_tests 12:31:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:31:50 INFO - Python 2.7.3 12:31:50 INFO - Return code: 0 12:31:50 INFO - grabbing minidump binary from tooltool 12:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:50 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 0x1e02930>, '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 0x1e03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e03cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:31:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:31:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:31:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:31:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:31:50 INFO - Return code: 0 12:31:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:31:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:31:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:31:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:31:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:31:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:31:50 INFO - Using env: {'DISPLAY': ':0', 12:31:50 INFO - 'HOME': '/home/cltbld', 12:31:50 INFO - 'LANG': 'en_US.UTF-8', 12:31:50 INFO - 'LANGUAGE': 'en_US:en', 12:31:50 INFO - 'LOGNAME': 'cltbld', 12:31:50 INFO - 'MAIL': '/var/mail/cltbld', 12:31:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:31:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:50 INFO - 'MOZ_NO_REMOTE': '1', 12:31:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:50 INFO - 'NO_EM_RESTART': '1', 12:31:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:50 INFO - 'PWD': '/builds/slave/test', 12:31:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:31:50 INFO - 'SHELL': '/bin/bash', 12:31:50 INFO - 'SHLVL': '1', 12:31:50 INFO - 'TERM': 'linux', 12:31:50 INFO - 'TMOUT': '86400', 12:31:50 INFO - 'USER': 'cltbld', 12:31:50 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068', 12:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:50 INFO - '_': '/tools/buildbot/bin/python'} 12:31:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:31:50 INFO - mozversion application_buildid: 20161027093009 12:31:50 INFO - mozversion application_changeset: 9888f1a23001fde6435e1a9ed7e6d3af8dd988d8 12:31:50 INFO - mozversion application_display_name: Nightly 12:31:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:31:50 INFO - mozversion application_name: Firefox 12:31:50 INFO - mozversion application_remotingname: firefox 12:31:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:31:50 INFO - mozversion application_vendor: Mozilla 12:31:50 INFO - mozversion application_version: 52.0a1 12:31:50 INFO - mozversion platform_buildid: 20161027093009 12:31:50 INFO - mozversion platform_changeset: 9888f1a23001fde6435e1a9ed7e6d3af8dd988d8 12:31:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:31:50 INFO - mozversion platform_version: 52.0a1 12:31:50 INFO - using testdate: 1477596710 12:31:50 INFO - actual date: 1477596710 12:31:50 INFO - starting webserver on 'localhost:55519' 12:31:50 INFO - SUITE-START | Running 2 tests 12:31:50 INFO - TEST-START | dromaeo_css 12:31:50 INFO - operating with platform_type : linux_ 12:31:50 INFO - Initialising browser for dromaeo_css test... 12:31:50 INFO - TEST-INFO | started process 31947 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYwN0dP/profile http://localhost:55519/getInfo.html) 12:31:55 INFO - PROCESS | 31947 | __metrics Screen width/height:1600/1200 12:31:55 INFO - PROCESS | 31947 | colorDepth:24 12:31:55 INFO - PROCESS | 31947 | Browser inner width/height: 1024/697 12:31:55 INFO - PROCESS | 31947 | __metrics 12:31:56 ERROR - PROCESS | 31947 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 12:31:57 INFO - TEST-INFO | 31947: exit 0 12:31:57 INFO - Browser initialized. 12:31:57 INFO - Running cycle 1/1 for dromaeo_css test... 12:31:57 INFO - TEST-INFO | started process 32077 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYwN0dP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:32:09 INFO - PROCESS | 32077 | RSS: Main: 182788096 12:32:09 INFO - PROCESS | 32077 | 12:32:59 INFO - PROCESS | 32077 | 1477596779291 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] 12:35:11 INFO - PROCESS | 32077 | Cycle 1(1): loaded http://localhost:55519/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55519/tests/dromaeo/cssquery-ext.html) 12:35:12 INFO - PROCESS | 32077 | RSS: Main: 196579328 12:35:12 INFO - PROCESS | 32077 | 12:38:14 INFO - PROCESS | 32077 | Cycle 1(1): loaded http://localhost:55519/tests/dromaeo/cssquery-ext.html (next: http://localhost:55519/tests/dromaeo/cssquery-jquery.html) 12:38:15 INFO - PROCESS | 32077 | RSS: Main: 194351104 12:38:15 INFO - PROCESS | 32077 | 12:41:17 INFO - PROCESS | 32077 | Cycle 1(1): loaded http://localhost:55519/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55519/tests/dromaeo/cssquery-mootools.html) 12:41:17 INFO - PROCESS | 32077 | RSS: Main: 196579328 12:41:17 INFO - PROCESS | 32077 | 12:44:19 INFO - PROCESS | 32077 | Cycle 1(1): loaded http://localhost:55519/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55519/tests/dromaeo/cssquery-prototype.html) 12:44:20 INFO - PROCESS | 32077 | RSS: Main: 193101824 12:44:20 INFO - PROCESS | 32077 | 12:47:23 INFO - PROCESS | 32077 | Cycle 1(1): loaded http://localhost:55519/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55519/tests/dromaeo/cssquery-yui.html) 12:47:23 INFO - PROCESS | 32077 | RSS: Main: 196509696 12:47:23 INFO - PROCESS | 32077 | 12:50:26 INFO - PROCESS | 32077 | Cycle 1(1): loaded http://localhost:55519/tests/dromaeo/cssquery-yui.html (next: http://localhost:55519/tests/dromaeo/cssquery-dojo.html) 12:50:26 INFO - PROCESS | 32077 | RSS: Main: 195969024 12:50:26 INFO - PROCESS | 32077 | 12:50:26 INFO - PROCESS | 32077 | __start_tp_report 12:50:26 INFO - PROCESS | 32077 | _x_x_mozilla_page_load 12:50:26 INFO - PROCESS | 32077 | _x_x_mozilla_page_load_details 12:50:26 INFO - PROCESS | 32077 | |i|pagename|runs| 12:50:26 INFO - PROCESS | 32077 | |0;dojo.html;3094.6441159266683;3105.146084826671;3115.704008119228;3142.827144507052;3150.9916826615477;5303.178007408857;5457.590680698949;5515.72421378931;5531.1426728856995;5545.473180047894;5339.199120131982;5395.136778115502;5467.917981230285;5494.835154945358;5545.750441230144;4928.679635823669;4986.900261994758;4988.850334489953;4990.500949904998;5080.110980578403;4979.10376132296;5037.697738135706;5044.117279476095;5044.596432285409;5103.464136265694;4866.075445665348;5030.044291584587;5062.620303477235;5098.6685865419;5104.285400043997;4885.2916327132725;4923.064617722621;4945.802167913279;4976.402831660224;5033.521815427565;4839.959408727141;4844.491328410501;4867.415910090812;4869.391326084239;4938.209886418156;5325.334333208349;5349.786008559653;5372.57019438444;5410.08028635129;5425.647332923348;5728.627639203439;5786.218860453827;5805.477507024388;5810.041343178371;5816.272965879265;5841.357450680422;5867.882642347172;5885.4997325227405;5893.793717219876;5910.497607703351;5323.733813309319;5372.57019438444;5452.536534394581;5469;5492.038893193715;5953.583249172603;5959.0763431668165;5983.910241346383;6015.187949626745;6119.571629985859;5796.88406231873;5810.302763668386;5811.941880581225;5816.709164541756;5821.679807610622;5692.7722891083895;5873.500752436005;5881.235439392852;5886.587938844325;5894.557908156819;5560.610757247035;5676.517496012802;5719.685417302088;5746.367899531048;5787.797427090116;5790.942090579125;5792.131180322901;5795.623284486495;5797.710114494258;5799.652020878761;4388.407564978751;4419.535948725402;4424.491183513873;4427.291633338715;4427.889302767392;3975;3986.9003274917777;4003.039270575099;4011.859584914572;4019.3569028955226;5469.753861076261;5493.2034854945805;5509.531689806411;5517.310336207974;5524.06090964529;5814.94185058144;5822.563307751935;5829.795957141479;5861.062230043172;5890.2342695449315;5568.415316391802;5594.021046316879;5601.047821870292;5614.354349249807;5706.914396284059;4935.950640493621;4936.654434189572;4976.850694479099;4996.275540046746;5023.497650234947;5784.913226301609;5896.734646940812;5937.139114828326;5984.371640977722;6069.605475644069;5897.439743224387;5905.232319798399;5912.46787789101;5939.049752039653;5957.434043765836;5957.731902064331;5998.430149135826;6002.309734380602;6013.158157857816;6029;5612.045952188057;5662.150677398423;5740.512056475246;5747.252857128547;5771.7979870706;5820.912686309624;5948.970255148696;5953.464188223081;6004.399560044136;6024.307204671343;5759.424057594207;5760.337561180518;5765.365809760839;5773.91339129905;5774.711264436845;5537.640053396516;5539.086050801573;5743.942560574341;5766.538676905921;5787.9421205789085;5652.463016013472;5655.802046928337;5665;5702.258706368146;5704.743286552032;5708.971455142698;5715;5748.6838223898085;5754.424557544212;5764;5490.91763623538;5650.660960342392;5654.6889921054735;5661.915071273852;5665.065264231521 12:50:26 INFO - PROCESS | 32077 | |1;ext.html;542.2779432910728;586.0564491169218;601.1553766957425;608.2245137449754;629.6725702634633;41486.585134148685;42393.57606423935;42573.574264257346;45656;45731.31403028957;42780.35829462553;43615.563844361626;43671.78164109175;43762.56237437625;43791.34312985308;8758.86861697075;8895.510746908918;8897.955510222473;8898.37711360205;8913;8726.214640682338;8739.650413983465;8773.912260877405;8775.605097770616;8814.603342849556;8778;8839.07189745074;8861.936567611896;8891.822163556724;8913.866292005625;8720.084391138935;8784.12158784123;8864.601092950832;8891.555422228863;8892.510911899843;8584.785380365542;8649.65401383944;8660.610272537751;8677.349198810052;8684.348673849487;41107.58892411068;41321;41371.7931410344;41466;41487.170256595;3352.195473086466;3355.9664403355896;3427.057559171223;3464.0993341731078;3847.7883716395586;29993.250168745955;31736.523952140506;32226;32559.51160732591;33412.16469588255;4256.361545768129;4344.695871289011;4402.697976517612;4532.7053741507025;4591.724496530219;315837;316407;317080;317305;317661;58098;58129;58579.70710146422;58633.70683146557;58654.706726466946;61291.693541532004;61367.693161533905;61413.38586614166;61523;61601.383986160465;16947.91526042362;17087.060211688477;17166.39917602878;17203.22585483656;17223.827761722223;13050.869491304966;13069;13110.868891311156;13155.342232888317;13155.53955611549;18026.746656667918;18227.71648662563;18429.26282948667;18634.34779782701;18741.90629046846;6927.238003819576;7095.467839912028;7184.281571842878;7382.261773822682;7434.368078713262;975.6390135649855;1018.6791160784329;1097.5719469406938;1114.7714718482691;1125.5272785430138;31146.532802007987;31536.526952095737;31561.36877262442;31672.208194795316;31707.841460792548;1025.1286406554518;1075.7756948131491;1111.6710491520253;1172.1443346357207;1197.3175290084569;15042.924785376223;16000.599985000235;16206.594835129215;16209.270582823801;16835.663286734198;460678;463957;464859;465455;465643.07676924363;57170;57385.13922291169;57702.71148644314;57972.710136449045;57998.7100064497;1345.132389608697;1356.2879488268738;1360.6530334764573;1385.9999999999798;1394.079907261223;29799.55300670535;30571.694283056884;31509.527357089202;31570.684293156773;31572.684273156974;47334;47964.280535791295;48053.75973120112;48075.27887081627;48145.75927120342;394507;396143;397177;398376;398913;26935.299162671654;27338.45323093567;27480.862595686893;27506.449871002867;27605.30986725348;44927.32609010802;45194;45824.08351832878;46411;46953;38835.61164388433;38838.80580597079;39777;40896.1820763589;41025.384619231336;38922.416163758135;39592.40611390774;39655.60344396519;39698.60301397065;40660.510831037434;38996;40156.39765403463;40306.79846600748;40351;40392.596074038884;29533.409331813673;33626;34738.65261347354;35175.47236791501;35401.645983539835;27038.594421084093;27170.1848944532;27242;27416.314592135357;27577 12:50:26 INFO - PROCESS | 32077 | |2;jquery.html;373.3559609673312;378.71028663072747;379.14313651148404;390.07746679103894;398.09433538699454;17398;19191.520211994706;19293.421197364067;19370.806291937075;19455.416337509898;15808.604784880385;16166.434174803884;16537.751933720974;16584.751228731548;16597.41909033184;5533.280673512448;5787.450192231731;5795.739191736361;5802.53579713624;5825.5048320892565;5464.562834973212;5701.0878259478495;5739;5748.626339287954;5764.365919748824;5672.546196304285;5690.459406356389;5705.144228365737;5734.483896449318;5749.856253593673;5487.149491828753;5750.971245143768;5832.56255780816;5853.970730146365;5917.053271476543;5523.199136125279;5660.235868157828;5683.630564013326;5691.971540142315;5788.507976821975;13268.800967985488;13482.595522134352;13519.932400337935;13557.525486607921;18148.727769083474;2127.914883404662;2192.2984644913477;2221.7000704904794;2402.303332033708;2441.987790061056;9480.857787133198;9531.52342382885;9547.474888881108;9710.854337184948;10579.471026448648;1645.7860478137766;1692.82225366336;1705.684448377042;1720.2946791815295;1795.4972607669874;74709;75129.62435187843;76500.61749691272;76715;76808.99999999945;10256.641017564349;10501.422421766723;10679.946600267105;10802.297850639683;11083.057940075023;14987.32557034936;15043.774343384857;15057.472988445352;15061.924690376478;15085.094894306376;7548.698052077855;7896.807136813641;7980.162082981319;8055.5972201389695;8186.54973976437;7475.476716629783;7492.550446973199;7546.773596792105;7723.7682869514;7806.1413244543055;4414.9558504414545;4472.59746622799;4474.888127796766;4651.62786977041;4764.71293778988;1921.28912302449;1923.7210604462275;1934.0312620128036;1981.128303546435;2033.5119571303076;391.64947372101807;395.5372214508974;1011.0647650922867;1047.7747284333905;1048.5596049659162;10484.475776211159;10549.789004219872;11217.831732524019;11467.08263338931;11564.306141631529;416.6729117642636;422.66398213420405;428.9828406863753;431.2733044819489;432.9458817647794;6054.3945605439985;6056.757729690763;6180.6600636965395;6257.8748425031245;6409.455196308366;261297;263882;264053;264095;294918;72203.63898180581;91431.54284228536;92324;92819;93825;424.73241857629495;439.3892489439618;439.56263517799357;439.7493428745584;440.07144924209894;10280.794384112425;10303.175745940456;10567.94716026415;10576.259661823598;10613.787724245627;29463.852680736458;29516.409671806014;40202;40363;41801.581984180986;50103;50169.24746128738;55253.1712024328;56369;58544;8136.430449868452;8439.409241353047;8469.407141500036;8491.787705307417;8918.331125165509;10889.945550272198;13250.933745331597;13290.933545332598;13363.732725345244;13555;11794;11917.76164476723;11982.940085299517;12035.578754743541;12100.213486123374;11344.659660209876;11418;11664.066874649838;11678.416079196177;11795;11761.764764704829;12027.097967652637;12139.514419423123;12314.399128113288;12350.691232718895;8282.917170828456;8441.62003224871;8582.82834343322;8622.741317760227;8639.883228609031;11084.501197446296;11550.306981581132;11617.186796924134;11664.88335116638;11816.822747658964 12:50:26 INFO - PROCESS | 32077 | |3;mootools.html;1462.1373389700075;1493.9253037348133;1631.3882294139698;1743.9128043597832;1748.9038102904344;7007.789766307019;7276.745313914014;7743.070831500221;8231.794205144866;8237;7795.571243581615;8063.677452901877;8065.677372905091;8239.299659528931;8248.298894593952;2145.9463513412134;2148.130007347027;2162.956740865182;2177.052981952848;2182.028997096285;2187.748408932969;2225.2322948582714;2284.257616274709;2289.2102224732525;2291.598970180212;2097.5490269592033;2106.189117189885;2110.45128266651;2117.6717608770664;2127.2979916627555;2019.2932473634185;2048.2216757632154;2048.23191303262;2048.9692654610194;2050.4976280811147;2157.2665293800183;2177.3250292409402;2195.1438938813876;2195.2645863635703;2198.8021078103047;8018.077921039038;8113;8172.836543269161;8228;8239.423240373177;4691.7654117294;4809.975950120262;4837.4920633333695;4857.319975203474;4859.052484765472;3147;3388.728901687859;3395.8811441599423;3396.3716712408036;3412.9146771330666;1048.6749107776614;1084.8752393474772;1140.8573928258968;1148.9482973266222;1155.83240430138;10937.726556836144;11047.72380690481;11115.888841111648;11140.442977851075;11230.550777968952;4263.360495925636;4467.30756732707;4495.617872480876;4602.792874320664;4604.631629469634;9254.305927055499;9348.345615806827;9373.578188981512;9376.156145946898;9381.43711377306;5066.645334826527;5079.568236699922;5090.898182036339;5095.566876815438;5114.207297868837;4087.5912408758886;4416.84541041062;4583;4643.303504474288;4652.720836749806;3743.5320584926885;3754.9812250939117;3765.4728338032696;3767.962320376761;3839.9616003840165;1231.9199252048768;1238.2817965579943;1241.453760345445;1247.650657815813;1254.0406588959454;863.9827203455895;965.1458459263603;972.1785091597731;978.3396207559869;1007.496251874063;5528.198411230349;5594.552435805126;5643.633163844337;5809.680467574324;5843.474087332161;413.2891426746052;420.09050405871557;422.6787641392564;432.5199029077721;439.5977680422442;3649.8357573908706;3720.9441858372147;3754.4931434256027;3754.6245375462236;3890.7860067695983;9569.425834449956;9901.108900199017;9906.900930990598;9917.15704165154;10001.599936002624;9142.725718228463;9755.951220243853;9797.06927841854;9914.702558923243;9988.550515226687;7176.820579485555;7503.9624801876735;7537.133229678548;7554.962225188949;7587.127480339721;5469.535089517435;5626.409227031103;5688.061469857593;5720.3421606515785;5839.708014599338;9113.817723645623;9142.177204051668;9167.12912273333;9245.768855778659;9252.583633736633;8682.262007729161;9022.368434209804;9103.544822758968;9225.953870230605;9238.353315267866;6690.69891854858;6834.521583489108;6901.447884169354;7103.82240443993;7260.564366138048;7680.731174409092;7724.575148366894;7736.226377362219;7737.226277372218;7755.650995705094;6665.300143484864;6790.898136528055;6792.286809885089;6884.862302754017;7104.183018952886;6591.945288753776;6597.241317248386;6608.4382827458285;6628.933710662832;6656.467482601477;6182.907256391248;6261.186045814015;6431.163948686641;6473.320301368477;6493.448056915026;4746.715197088186;4783.282507623884;4786.779371260306;4804.159272127434;4873.731944742932;4898.118338699069;4961.404631444249;4961.751912404293;5026.4973502649445;5051.191809310492 12:50:26 INFO - PROCESS | 32077 | |4;prototype.html;327.37634805695154;330.3920785754212;338.0500792772309;341.44344718109477;342.8611412377988;5487.6981766002855;5583.441655834415;5656.547476201904;5703.743331550085;5723.828285151447;5346.866328341794;5476.644018138818;5521.806736764214;5540.972295138518;5561.860953476165;4333.436653235083;4364.563543645641;4364.67264955128;4365.2142614329405;4385.978070109645;4102.548719640837;4289.635380992604;4305.913881722364;4314.158739045887;4352.630026447756;4251.149770046003;4255.63827074699;4277.337012763011;4288.785560721967;4297.226499230137;4263.957360426402;4267.679924005696;4303.849365272232;4306.720063195882;4333.58830911063;3554.9512893696165;3792.772433653962;3793.7534060285993;3793.905152371185;3797.810109494514;5308.761105750251;5324.467553244684;5346.219965617857;5352.437994010612;5375.3280839895015;4891.706497610155;4892.461829198785;4906.950930490721;4940.89905378535;4947.975260123712;5618.073017952033;5754.3094828620415;5755.539556835485;5761.481466667978;5777.908818781932;4065.2072845795083;4068.9186216275507;4072.9796351018354;4080.489938757655;4081.3877918312196;5951.732172052225;6040.335563088057;6051.848703782397;6067.453929146398;6076.726547305382;3963.326234540135;4112.588741125924;4170.687198460128;4189.832406703697;4207.948012996751;4201.6008479194425;4243.830246790156;4244.342126970325;4256.170046840898;4258.297380932174;4867.3915760529935;4886.413630364379;4912.459629440758;4919.852404427873;4936;5606.196901549225;5730.856728581735;5848.912266316009;5899.351071382144;5940.376260492672;1501.647112928461;1509.7056074065451;1510.4562357551272;1511.3425659838006;1516.5753588995099;948.7201275623707;956.2493442647627;956.6460409648474;960.2701946520694;988.211337479165;4989.750512474362;4994;5004.499550044967;5034.709207310665;5053.873653158627;5197.350331208599;5287.430984085804;5321.361436627552;5355.179239058739;5377.327834020747;4976.552110310089;4999.725015124203;5001.799928002912;5356.651817631841;5739.311282646026;3187.2828613561765;3189.473736833443;3202.407554602406;3209.8876539321013;3218.1471909943884;6077.6353418795015;6204.224471941007;6237.937620623827;6275.274299567564;6298.685065746694;5984.371640977722;6036.3360030396625;6042.969785151046;6066.878662426727;6150.200473938359;6131.325554189036;6158.938410615926;6171.814845554551;6248.968755156286;6300.810975670737;5900.967330717193;5947.286325640951;5963.970180149072;5987.191729116687;6099.79760625675;5916.852078698067;5940.762369505172;5980.880382392241;5985.760569577168;5991.850203744767;6034.366391528826;6221.191245138103;6238.845813524513;6265.780697675559;6275.497960163085;4138.875833724993;4197.643200328006;4218.873433796991;4227.788610569521;4233.470816147981;5977.983742763654;5987.742574059496;6025.216721826135;6032.8793424132145;6051.394860513913;5585.910747404218;5869.4717475427415;5913.881722365442;5927.4665280125;5956.255468066492;5894.941050589611;5939.673317967553;5939.881202375842;5957.3744756799915;5960.850978725566;5688.402717714746;5899.764009439575;5947.375525569752;5955.166276721176;5975.581709280309;5841.1238314253205;5853.795117170878;5854.121881717776;5890.3226128994;5914.585978981602;5805.94194058054;5806.2451881255165;5828.794163210133;5837.620554663933;5845.41545845429 12:50:26 INFO - PROCESS | 32077 | |5;yui.html;722.1911459165733;761.7752762934936;764.7055883484857;780.785284046887;807.5881300536724;13316.334183290834;13951.581452556415;13958.651033724162;13964;14031.438742450302;13016.934915325433;13163.47346106157;13186.802197967014;13199.34003299836;13215.074944753847;788.8067423481241;799.856025915335;802.6548584108831;808.1393316118345;809.5749731391008;804.6499772598909;812.3744716568239;814.1939479914871;815.2092470303796;815.5881279953616;841.7558907916697;845.750503601439;846.9237768600825;851.3444647621328;851.9062903080656;842.5702891525335;842.7724514381114;848.8769128476337;850.090403268503;851.5742128935532;620.6369273974731;623.5011990407701;625.9812205633838;626.614632001316;626.9937300626981;11805.291682499077;11818.704532386673;11849.585264515701;11862.762744745056;11904.464299106561;10911.945440272828;11125.666230013032;11160.888391116147;11454.026407755267;11490.540378384854;10285.794284114276;10359.689209323733;10452.477376131239;10472.633457829015;10501.4224217668;3590.9281814363567;3594.8741794037346;3679.816009199529;3804.8287827047848;3835.520559930009;66692.33307666909;66912.99999999952;67178;68246;68699.3130068698;8678.479291242546;8735.825283494294;9005.189532942066;9121.863172052424;9338.299627527827;18955.24179032851;19094.71357929632;19151.233950642098;19336.03319834003;19389.80610193908;7114.430845532345;7119.644017799193;7139;7315.158756743042;7429.665665045086;4314.503832059353;4373.759443230653;4375.6280716138845;4401.383806267125;4424.778761061934;3269.509573563937;3400.2009527760956;3409.1817963688536;3409.1988382730037;3427.3145370925417;513.5301199402579;517.2603177456274;521.0932976620653;531.224412357954;534.3320848938827;695.4957655699577;697.1390332938817;697.9476539259474;711.4735096028901;722.1550785580883;8818.603162857687;8907.599158037903;9236;9305.720828375159;9396.436213827192;586.9295684517886;622.4180391334118;657.6974591687878;673.3266733266734;695.3602685529326;4192.622663960258;4196.748195108304;4433.179861725591;4506.842260520932;4534.977325113353;54963;81367.593162035;87673.56163219143;94095.52952235332;96192.9378121511;46797.76601117041;48258.75870620694;55112;62753.372466275665;70104.6494767523;50599.74700126476;61144.69427652922;61320.38679613147;62347;62916.68541657354;8871.379003469696;9724.9027509724;9760.559860034991;9768.560414781494;9805.1175394212;43025.56974430341;43401.34897976596;43841.123177535635;44372.202778925515;44524.55475445204;54843;60204.698976504835;61343.693281535096;61625;63409.682951584946;10180.898191017995;10449.425281609585;12334.444949977093;12456.439460224494;13007;11140.832887506856;11430.714232144262;13878.167309961435;14196.432142714175;14696.55910322692;12278.263304201777;12849.935750321189;13336;13614.319284035957;14004.439822407398;12869.871301287241;12901.161424507378;12961.805572916226;13399.799003015158;13886.166829990232;12832.165909215872;12875.80686289725;13334.933325333312;13787.103838250481;13889.166650001032;9973.750656233653;10487.906067709891;10603.483959126055;10619.30974486656;10738.570457181626;8731.956340218258;9566.572436044744;10013.849792252977;10109.443980580845;10791.730206744895 12:50:26 INFO - PROCESS | 32077 | __end_tp_report 12:50:26 INFO - PROCESS | 32077 | __start_cc_report 12:50:26 INFO - PROCESS | 32077 | _x_x_mozilla_cycle_collect,324 12:50:26 INFO - PROCESS | 32077 | __end_cc_report 12:50:26 INFO - PROCESS | 32077 | __startTimestamp1477597826582__endTimestamp 12:50:26 INFO - PROCESS | 32077 | 12:50:26 INFO - PROCESS | 32077 | ------- Summary: start ------- 12:50:26 INFO - PROCESS | 32077 | Number of tests: 6 12:50:26 INFO - PROCESS | 32077 | 12:50:26 INFO - PROCESS | 32077 | [#0] dojo.html Cycles:165 Average:5421.47 Median:5655.80 stddev:621.66 (11.0%) stddev-sans-first:596.17 12:50:26 INFO - PROCESS | 32077 | Values: 3094.6 3105.1 3115.7 3142.8 3151.0 5303.2 5457.6 5515.7 5531.1 5545.5 5339.2 5395.1 5467.9 5494.8 5545.8 4928.7 4986.9 4988.9 4990.5 5080.1 4979.1 5037.7 5044.1 5044.6 5103.5 4866.1 5030.0 5062.6 5098.7 5104.3 4885.3 4923.1 4945.8 4976.4 5033.5 4840.0 4844.5 4867.4 4869.4 4938.2 5325.3 5349.8 5372.6 5410.1 5425.6 5728.6 5786.2 5805.5 5810.0 5816.3 5841.4 5867.9 5885.5 5893.8 5910.5 5323.7 5372.6 5452.5 5469.0 5492.0 5953.6 5959.1 5983.9 6015.2 6119.6 5796.9 5810.3 5811.9 5816.7 5821.7 5692.8 5873.5 5881.2 5886.6 5894.6 5560.6 5676.5 5719.7 5746.4 5787.8 5790.9 5792.1 5795.6 5797.7 5799.7 4388.4 4419.5 4424.5 4427.3 4427.9 3975.0 3986.9 4003.0 4011.9 4019.4 5469.8 5493.2 5509.5 5517.3 5524.1 5814.9 5822.6 5829.8 5861.1 5890.2 5568.4 5594.0 5601.0 5614.4 5706.9 4936.0 4936.7 4976.9 4996.3 5023.5 5784.9 5896.7 5937.1 5984.4 6069.6 5897.4 5905.2 5912.5 5939.0 5957.4 5957.7 5998.4 6002.3 6013.2 6029.0 5612.0 5662.2 5740.5 5747.3 5771.8 5820.9 5949.0 5953.5 6004.4 6024.3 5759.4 5760.3 5765.4 5773.9 5774.7 5537.6 5539.1 5743.9 5766.5 5787.9 5652.5 5655.8 5665.0 5702.3 5704.7 5709.0 5715.0 5748.7 5754.4 5764.0 5490.9 5650.7 5654.7 5661.9 5665.1 12:50:26 INFO - PROCESS | 32077 | 12:50:26 INFO - PROCESS | 32077 | [#1] ext.html Cycles:180 Average:55782.34 Median:40526.55 stddev:104875.27 (258.8%) stddev-sans-first:105087.47 12:50:26 INFO - PROCESS | 32077 | Values: 542.3 586.1 601.2 608.2 629.7 41486.6 42393.6 42573.6 45656.0 45731.3 42780.4 43615.6 43671.8 43762.6 43791.3 8758.9 8895.5 8898.0 8898.4 8913.0 8726.2 8739.7 8773.9 8775.6 8814.6 8778.0 8839.1 8861.9 8891.8 8913.9 8720.1 8784.1 8864.6 8891.6 8892.5 8584.8 8649.7 8660.6 8677.3 8684.3 41107.6 41321.0 41371.8 41466.0 41487.2 3352.2 3356.0 3427.1 3464.1 3847.8 29993.3 31736.5 32226.0 32559.5 33412.2 4256.4 4344.7 4402.7 4532.7 4591.7 315837.0 316407.0 317080.0 317305.0 317661.0 58098.0 58129.0 58579.7 58633.7 58654.7 61291.7 61367.7 61413.4 61523.0 61601.4 16947.9 17087.1 17166.4 17203.2 17223.8 13050.9 13069.0 13110.9 13155.3 13155.5 18026.7 18227.7 18429.3 18634.3 18741.9 6927.2 7095.5 7184.3 7382.3 7434.4 975.6 1018.7 1097.6 1114.8 1125.5 31146.5 31536.5 31561.4 31672.2 31707.8 1025.1 1075.8 1111.7 1172.1 1197.3 15042.9 16000.6 16206.6 16209.3 16835.7 460678.0 463957.0 464859.0 465455.0 465643.1 57170.0 57385.1 57702.7 57972.7 57998.7 1345.1 1356.3 1360.7 1386.0 1394.1 29799.6 30571.7 31509.5 31570.7 31572.7 47334.0 47964.3 48053.8 48075.3 48145.8 394507.0 396143.0 397177.0 398376.0 398913.0 26935.3 27338.5 27480.9 27506.4 27605.3 44927.3 45194.0 45824.1 46411.0 46953.0 38835.6 38838.8 39777.0 40896.2 41025.4 38922.4 39592.4 39655.6 39698.6 40660.5 38996.0 40156.4 40306.8 40351.0 40392.6 29533.4 33626.0 34738.7 35175.5 35401.6 27038.6 27170.2 27242.0 27416.3 27577.0 12:50:26 INFO - PROCESS | 32077 | 12:50:26 INFO - PROCESS | 32077 | [#2] jquery.html Cycles:180 Average:21419.84 Median:393.59 stddev:46390.38 (11786.4%) stddev-sans-first:46493.60 12:50:26 INFO - PROCESS | 32077 | Values: 373.4 378.7 379.1 390.1 398.1 17398.0 19191.5 19293.4 19370.8 19455.4 15808.6 16166.4 16537.8 16584.8 16597.4 5533.3 5787.5 5795.7 5802.5 5825.5 5464.6 5701.1 5739.0 5748.6 5764.4 5672.5 5690.5 5705.1 5734.5 5749.9 5487.1 5751.0 5832.6 5854.0 5917.1 5523.2 5660.2 5683.6 5692.0 5788.5 13268.8 13482.6 13519.9 13557.5 18148.7 2127.9 2192.3 2221.7 2402.3 2442.0 9480.9 9531.5 9547.5 9710.9 10579.5 1645.8 1692.8 1705.7 1720.3 1795.5 74709.0 75129.6 76500.6 76715.0 76809.0 10256.6 10501.4 10679.9 10802.3 11083.1 14987.3 15043.8 15057.5 15061.9 15085.1 7548.7 7896.8 7980.2 8055.6 8186.5 7475.5 7492.6 7546.8 7723.8 7806.1 4415.0 4472.6 4474.9 4651.6 4764.7 1921.3 1923.7 1934.0 1981.1 2033.5 391.6 395.5 1011.1 1047.8 1048.6 10484.5 10549.8 11217.8 11467.1 11564.3 416.7 422.7 429.0 431.3 432.9 6054.4 6056.8 6180.7 6257.9 6409.5 261297.0 263882.0 264053.0 264095.0 294918.0 72203.6 91431.5 92324.0 92819.0 93825.0 424.7 439.4 439.6 439.7 440.1 10280.8 10303.2 10567.9 10576.3 10613.8 29463.9 29516.4 40202.0 40363.0 41801.6 50103.0 50169.2 55253.2 56369.0 58544.0 8136.4 8439.4 8469.4 8491.8 8918.3 10889.9 13250.9 13290.9 13363.7 13555.0 11794.0 11917.8 11982.9 12035.6 12100.2 11344.7 11418.0 11664.1 11678.4 11795.0 11761.8 12027.1 12139.5 12314.4 12350.7 8282.9 8441.6 8582.8 8622.7 8639.9 11084.5 11550.3 11617.2 11664.9 11816.8 12:50:26 INFO - PROCESS | 32077 | 12:50:26 INFO - PROCESS | 32077 | [#3] mootools.html Cycles:180 Average:5310.36 Median:5038.84 stddev:2947.12 (58.5%) stddev-sans-first:2941.20 12:50:26 INFO - PROCESS | 32077 | Values: 1462.1 1493.9 1631.4 1743.9 1748.9 7007.8 7276.7 7743.1 8231.8 8237.0 7795.6 8063.7 8065.7 8239.3 8248.3 2145.9 2148.1 2163.0 2177.1 2182.0 2187.7 2225.2 2284.3 2289.2 2291.6 2097.5 2106.2 2110.5 2117.7 2127.3 2019.3 2048.2 2048.2 2049.0 2050.5 2157.3 2177.3 2195.1 2195.3 2198.8 8018.1 8113.0 8172.8 8228.0 8239.4 4691.8 4810.0 4837.5 4857.3 4859.1 3147.0 3388.7 3395.9 3396.4 3412.9 1048.7 1084.9 1140.9 1148.9 1155.8 10937.7 11047.7 11115.9 11140.4 11230.6 4263.4 4467.3 4495.6 4602.8 4604.6 9254.3 9348.3 9373.6 9376.2 9381.4 5066.6 5079.6 5090.9 5095.6 5114.2 4087.6 4416.8 4583.0 4643.3 4652.7 3743.5 3755.0 3765.5 3768.0 3840.0 1231.9 1238.3 1241.5 1247.7 1254.0 864.0 965.1 972.2 978.3 1007.5 5528.2 5594.6 5643.6 5809.7 5843.5 413.3 420.1 422.7 432.5 439.6 3649.8 3720.9 3754.5 3754.6 3890.8 9569.4 9901.1 9906.9 9917.2 10001.6 9142.7 9756.0 9797.1 9914.7 9988.6 7176.8 7504.0 7537.1 7555.0 7587.1 5469.5 5626.4 5688.1 5720.3 5839.7 9113.8 9142.2 9167.1 9245.8 9252.6 8682.3 9022.4 9103.5 9226.0 9238.4 6690.7 6834.5 6901.4 7103.8 7260.6 7680.7 7724.6 7736.2 7737.2 7755.7 6665.3 6790.9 6792.3 6884.9 7104.2 6591.9 6597.2 6608.4 6628.9 6656.5 6182.9 6261.2 6431.2 6473.3 6493.4 4746.7 4783.3 4786.8 4804.2 4873.7 4898.1 4961.4 4961.8 5026.5 5051.2 12:50:26 INFO - PROCESS | 32077 | 12:50:26 INFO - PROCESS | 32077 | [#4] prototype.html Cycles:180 Average:4861.81 Median:5482.17 stddev:1445.42 (26.4%) stddev-sans-first:1408.84 12:50:26 INFO - PROCESS | 32077 | Values: 327.4 330.4 338.1 341.4 342.9 5487.7 5583.4 5656.5 5703.7 5723.8 5346.9 5476.6 5521.8 5541.0 5561.9 4333.4 4364.6 4364.7 4365.2 4386.0 4102.5 4289.6 4305.9 4314.2 4352.6 4251.1 4255.6 4277.3 4288.8 4297.2 4264.0 4267.7 4303.8 4306.7 4333.6 3555.0 3792.8 3793.8 3793.9 3797.8 5308.8 5324.5 5346.2 5352.4 5375.3 4891.7 4892.5 4907.0 4940.9 4948.0 5618.1 5754.3 5755.5 5761.5 5777.9 4065.2 4068.9 4073.0 4080.5 4081.4 5951.7 6040.3 6051.8 6067.5 6076.7 3963.3 4112.6 4170.7 4189.8 4207.9 4201.6 4243.8 4244.3 4256.2 4258.3 4867.4 4886.4 4912.5 4919.9 4936.0 5606.2 5730.9 5848.9 5899.4 5940.4 1501.6 1509.7 1510.5 1511.3 1516.6 948.7 956.2 956.6 960.3 988.2 4989.8 4994.0 5004.5 5034.7 5053.9 5197.4 5287.4 5321.4 5355.2 5377.3 4976.6 4999.7 5001.8 5356.7 5739.3 3187.3 3189.5 3202.4 3209.9 3218.1 6077.6 6204.2 6237.9 6275.3 6298.7 5984.4 6036.3 6043.0 6066.9 6150.2 6131.3 6158.9 6171.8 6249.0 6300.8 5901.0 5947.3 5964.0 5987.2 6099.8 5916.9 5940.8 5980.9 5985.8 5991.9 6034.4 6221.2 6238.8 6265.8 6275.5 4138.9 4197.6 4218.9 4227.8 4233.5 5978.0 5987.7 6025.2 6032.9 6051.4 5585.9 5869.5 5913.9 5927.5 5956.3 5894.9 5939.7 5939.9 5957.4 5960.9 5688.4 5899.8 5947.4 5955.2 5975.6 5841.1 5853.8 5854.1 5890.3 5914.6 5805.9 5806.2 5828.8 5837.6 5845.4 12:50:26 INFO - PROCESS | 32077 | 12:50:26 INFO - PROCESS | 32077 | [#5] yui.html Cycles:180 Average:16462.41 Median:515.40 stddev:21695.88 (4209.6%) stddev-sans-first:21724.55 12:50:26 INFO - PROCESS | 32077 | Values: 722.2 761.8 764.7 780.8 807.6 13316.3 13951.6 13958.7 13964.0 14031.4 13016.9 13163.5 13186.8 13199.3 13215.1 788.8 799.9 802.7 808.1 809.6 804.6 812.4 814.2 815.2 815.6 841.8 845.8 846.9 851.3 851.9 842.6 842.8 848.9 850.1 851.6 620.6 623.5 626.0 626.6 627.0 11805.3 11818.7 11849.6 11862.8 11904.5 10911.9 11125.7 11160.9 11454.0 11490.5 10285.8 10359.7 10452.5 10472.6 10501.4 3590.9 3594.9 3679.8 3804.8 3835.5 66692.3 66913.0 67178.0 68246.0 68699.3 8678.5 8735.8 9005.2 9121.9 9338.3 18955.2 19094.7 19151.2 19336.0 19389.8 7114.4 7119.6 7139.0 7315.2 7429.7 4314.5 4373.8 4375.6 4401.4 4424.8 3269.5 3400.2 3409.2 3409.2 3427.3 513.5 517.3 521.1 531.2 534.3 695.5 697.1 697.9 711.5 722.2 8818.6 8907.6 9236.0 9305.7 9396.4 586.9 622.4 657.7 673.3 695.4 4192.6 4196.7 4433.2 4506.8 4535.0 54963.0 81367.6 87673.6 94095.5 96192.9 46797.8 48258.8 55112.0 62753.4 70104.6 50599.7 61144.7 61320.4 62347.0 62916.7 8871.4 9724.9 9760.6 9768.6 9805.1 43025.6 43401.3 43841.1 44372.2 44524.6 54843.0 60204.7 61343.7 61625.0 63409.7 10180.9 10449.4 12334.4 12456.4 13007.0 11140.8 11430.7 13878.2 14196.4 14696.6 12278.3 12849.9 13336.0 13614.3 14004.4 12869.9 12901.2 12961.8 13399.8 13886.2 12832.2 12875.8 13334.9 13787.1 13889.2 9973.8 10487.9 10603.5 10619.3 10738.6 8732.0 9566.6 10013.8 10109.4 10791.7 12:50:26 INFO - PROCESS | 32077 | -------- Summary: end -------- 12:50:26 INFO - PROCESS | 32077 | 12:50:27 INFO - TEST-INFO | 32077: exit 0 12:50:27 INFO - TEST-OK | dromaeo_css | took 1116689ms 12:50:27 INFO - TEST-START | kraken 12:50:27 INFO - operating with platform_type : linux_ 12:50:27 INFO - Initialising browser for kraken test... 12:50:27 INFO - TEST-INFO | started process 32429 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqQIfqn/profile http://localhost:55519/getInfo.html) 12:50:32 INFO - PROCESS | 32429 | __metrics Screen width/height:1600/1200 12:50:32 INFO - PROCESS | 32429 | colorDepth:24 12:50:32 INFO - PROCESS | 32429 | Browser inner width/height: 1024/697 12:50:32 INFO - PROCESS | 32429 | __metrics 12:50:32 ERROR - PROCESS | 32429 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 12:50:33 INFO - TEST-INFO | 32429: exit 0 12:50:33 INFO - Browser initialized. 12:50:33 INFO - Running cycle 1/1 for kraken test... 12:50:33 INFO - TEST-INFO | started process 32553 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqQIfqn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:50:45 INFO - PROCESS | 32553 | RSS: Main: 183091200 12:50:45 INFO - PROCESS | 32553 | 12:50:48 INFO - PROCESS | 32553 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55519/tests/kraken/driver.html?testName=audio-beat-detection) 12:50:49 INFO - PROCESS | 32553 | RSS: Main: 196632576 12:50:49 INFO - PROCESS | 32553 | 12:50:52 INFO - PROCESS | 32553 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55519/tests/kraken/driver.html?testName=audio-dft) 12:50:52 INFO - PROCESS | 32553 | RSS: Main: 194793472 12:50:52 INFO - PROCESS | 32553 | 12:50:55 INFO - PROCESS | 32553 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55519/tests/kraken/driver.html?testName=audio-fft) 12:50:56 INFO - PROCESS | 32553 | RSS: Main: 191066112 12:50:56 INFO - PROCESS | 32553 | 12:50:58 INFO - PROCESS | 32553 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55519/tests/kraken/driver.html?testName=audio-oscillator) 12:50:59 INFO - PROCESS | 32553 | RSS: Main: 192479232 12:50:59 INFO - PROCESS | 32553 | 12:51:01 INFO - PROCESS | 32553 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55519/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:51:01 INFO - PROCESS | 32553 | RSS: Main: 191979520 12:51:01 INFO - PROCESS | 32553 | 12:51:05 INFO - PROCESS | 32553 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55519/tests/kraken/driver.html?testName=imaging-darkroom) 12:51:05 INFO - PROCESS | 32553 | RSS: Main: 192163840 12:51:05 INFO - PROCESS | 32553 | 12:51:09 INFO - PROCESS | 32553 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55519/tests/kraken/driver.html?testName=imaging-desaturate) 12:51:09 INFO - PROCESS | 32553 | RSS: Main: 193011712 12:51:09 INFO - PROCESS | 32553 | 12:51:12 INFO - PROCESS | 32553 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55519/tests/kraken/driver.html?testName=json-parse-financial) 12:51:13 INFO - PROCESS | 32553 | RSS: Main: 192212992 12:51:13 INFO - PROCESS | 32553 | 12:51:14 INFO - PROCESS | 32553 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55519/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:51:15 INFO - PROCESS | 32553 | RSS: Main: 192835584 12:51:15 INFO - PROCESS | 32553 | 12:51:17 INFO - PROCESS | 32553 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55519/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:51:17 INFO - PROCESS | 32553 | RSS: Main: 193159168 12:51:17 INFO - PROCESS | 32553 | 12:51:19 INFO - PROCESS | 32553 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55519/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:51:20 INFO - PROCESS | 32553 | RSS: Main: 192036864 12:51:20 INFO - PROCESS | 32553 | 12:51:23 INFO - PROCESS | 32553 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55519/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:51:23 INFO - PROCESS | 32553 | RSS: Main: 192126976 12:51:23 INFO - PROCESS | 32553 | 12:51:26 INFO - PROCESS | 32553 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55519/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:51:27 INFO - PROCESS | 32553 | RSS: Main: 192360448 12:51:27 INFO - PROCESS | 32553 | 12:51:29 INFO - PROCESS | 32553 | Cycle 1(1): loaded http://localhost:55519/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55519/tests/kraken/driver.html?testName=ai-astar) 12:51:29 INFO - PROCESS | 32553 | RSS: Main: 193728512 12:51:29 INFO - PROCESS | 32553 | 12:51:29 INFO - PROCESS | 32553 | __start_tp_report 12:51:29 INFO - PROCESS | 32553 | _x_x_mozilla_page_load 12:51:29 INFO - PROCESS | 32553 | _x_x_mozilla_page_load_details 12:51:29 INFO - PROCESS | 32553 | |i|pagename|runs| 12:51:29 INFO - PROCESS | 32553 | |0;ai-astar;107;113;114;114;114;115;113;115;113;113 12:51:29 INFO - PROCESS | 32553 | |1;audio-beat-detection;157;124;135;172;127;132;127;124;151;125 12:51:29 INFO - PROCESS | 32553 | |2;audio-dft;164;166;166;166;167;165;166;164;162;165 12:51:29 INFO - PROCESS | 32553 | |3;audio-fft;76;75;75;110;77;76;76;76;100;78 12:51:29 INFO - PROCESS | 32553 | |4;audio-oscillator;82;83;115;83;82;83;104;82;82;113 12:51:29 INFO - PROCESS | 32553 | |5;imaging-gaussian-blur;118;118;118;118;118;117;117;118;117;118 12:51:29 INFO - PROCESS | 32553 | |6;imaging-darkroom;149;149;148;146;148;155;148;148;146;148 12:51:29 INFO - PROCESS | 32553 | |7;imaging-desaturate;86;85;85;86;85;85;86;86;86;85 12:51:29 INFO - PROCESS | 32553 | |8;json-parse-financial;53;58;56;55;57;58;60;57;54;54 12:51:29 INFO - PROCESS | 32553 | |9;json-stringify-tinderbox;62;62;61;62;64;62;62;62;62;61 12:51:29 INFO - PROCESS | 32553 | |10;stanford-crypto-aes;81;89;80;87;81;80;85;81;90;81 12:51:29 INFO - PROCESS | 32553 | |11;stanford-crypto-ccm;147;131;141;138;145;147;142;136;179;140 12:51:29 INFO - PROCESS | 32553 | |12;stanford-crypto-pbkdf2;168;170;167;174;170;167;176;165;168;167 12:51:29 INFO - PROCESS | 32553 | |13;stanford-crypto-sha256-iterative;77;72;67;66;66;67;68;66;67;65 12:51:29 INFO - PROCESS | 32553 | __end_tp_report 12:51:29 INFO - PROCESS | 32553 | __start_cc_report 12:51:29 INFO - PROCESS | 32553 | _x_x_mozilla_cycle_collect,797 12:51:29 INFO - PROCESS | 32553 | __end_cc_report 12:51:29 INFO - PROCESS | 32553 | __startTimestamp1477597889337__endTimestamp 12:51:29 INFO - PROCESS | 32553 | 12:51:29 INFO - PROCESS | 32553 | ------- Summary: start ------- 12:51:29 INFO - PROCESS | 32553 | Number of tests: 14 12:51:29 INFO - PROCESS | 32553 | 12:51:29 INFO - PROCESS | 32553 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:2.28 (2.0%) stddev-sans-first:0.83 12:51:29 INFO - PROCESS | 32553 | Values: 107.0 113.0 114.0 114.0 114.0 115.0 113.0 115.0 113.0 113.0 12:51:29 INFO - PROCESS | 32553 | 12:51:29 INFO - PROCESS | 32553 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:133.50 stddev:16.77 (12.6%) stddev-sans-first:16.22 12:51:29 INFO - PROCESS | 32553 | Values: 157.0 124.0 135.0 172.0 127.0 132.0 127.0 124.0 151.0 125.0 12:51:29 INFO - PROCESS | 32553 | 12:51:29 INFO - PROCESS | 32553 | [#2] audio-dft Cycles:10 Average:165.10 Median:166.00 stddev:1.45 (0.9%) stddev-sans-first:1.48 12:51:29 INFO - PROCESS | 32553 | Values: 164.0 166.0 166.0 166.0 167.0 165.0 166.0 164.0 162.0 165.0 12:51:29 INFO - PROCESS | 32553 | 12:51:29 INFO - PROCESS | 32553 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:12.43 (16.4%) stddev-sans-first:13.00 12:51:29 INFO - PROCESS | 32553 | Values: 76.0 75.0 75.0 110.0 77.0 76.0 76.0 76.0 100.0 78.0 12:51:29 INFO - PROCESS | 32553 | 12:51:29 INFO - PROCESS | 32553 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:82.00 stddev:13.92 (17.0%) stddev-sans-first:14.39 12:51:29 INFO - PROCESS | 32553 | Values: 82.0 83.0 115.0 83.0 82.0 83.0 104.0 82.0 82.0 113.0 12:51:29 INFO - PROCESS | 32553 | 12:51:29 INFO - PROCESS | 32553 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 12:51:29 INFO - PROCESS | 32553 | Values: 118.0 118.0 118.0 118.0 118.0 117.0 117.0 118.0 117.0 118.0 12:51:29 INFO - PROCESS | 32553 | 12:51:29 INFO - PROCESS | 32553 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.00 stddev:2.51 (1.7%) stddev-sans-first:2.65 12:51:29 INFO - PROCESS | 32553 | Values: 149.0 149.0 148.0 146.0 148.0 155.0 148.0 148.0 146.0 148.0 12:51:29 INFO - PROCESS | 32553 | 12:51:29 INFO - PROCESS | 32553 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 12:51:29 INFO - PROCESS | 32553 | Values: 86.0 85.0 85.0 86.0 85.0 85.0 86.0 86.0 86.0 85.0 12:51:29 INFO - PROCESS | 32553 | 12:51:29 INFO - PROCESS | 32553 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:57.00 stddev:2.20 (3.9%) stddev-sans-first:2.01 12:51:29 INFO - PROCESS | 32553 | Values: 53.0 58.0 56.0 55.0 57.0 58.0 60.0 57.0 54.0 54.0 12:51:29 INFO - PROCESS | 32553 | 12:51:29 INFO - PROCESS | 32553 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 12:51:29 INFO - PROCESS | 32553 | Values: 62.0 62.0 61.0 62.0 64.0 62.0 62.0 62.0 62.0 61.0 12:51:29 INFO - PROCESS | 32553 | 12:51:29 INFO - PROCESS | 32553 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.00 stddev:3.89 (4.7%) stddev-sans-first:4.02 12:51:29 INFO - PROCESS | 32553 | Values: 81.0 89.0 80.0 87.0 81.0 80.0 85.0 81.0 90.0 81.0 12:51:29 INFO - PROCESS | 32553 | 12:51:29 INFO - PROCESS | 32553 | [#11] stanford-crypto-ccm Cycles:10 Average:144.60 Median:143.50 stddev:13.07 (9.1%) stddev-sans-first:13.84 12:51:29 INFO - PROCESS | 32553 | Values: 147.0 131.0 141.0 138.0 145.0 147.0 142.0 136.0 179.0 140.0 12:51:29 INFO - PROCESS | 32553 | 12:51:29 INFO - PROCESS | 32553 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.20 Median:169.00 stddev:3.43 (2.0%) stddev-sans-first:3.61 12:51:29 INFO - PROCESS | 32553 | Values: 168.0 170.0 167.0 174.0 170.0 167.0 176.0 165.0 168.0 167.0 12:51:29 INFO - PROCESS | 32553 | 12:51:29 INFO - PROCESS | 32553 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:67.00 stddev:3.67 (5.5%) stddev-sans-first:2.03 12:51:29 INFO - PROCESS | 32553 | Values: 77.0 72.0 67.0 66.0 66.0 67.0 68.0 66.0 67.0 65.0 12:51:29 INFO - PROCESS | 32553 | -------- Summary: end -------- 12:51:29 INFO - PROCESS | 32553 | 12:51:30 INFO - TEST-INFO | 32553: exit 0 12:51:30 INFO - TEST-OK | kraken | took 62947ms 12:51:30 INFO - SUITE-END | took 1179s 12:51:31 INFO - Completed test suite (00:19:40) 12:51:31 INFO - javascript benchmark 12:51:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6871.874815439309, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.6441159266683, 3105.146084826671, 3115.704008119228, 3142.827144507052, 3150.9916826615477, 5303.178007408857, 5457.590680698949, 5515.72421378931, 5531.1426728856995, 5545.473180047894, 5339.199120131982, 5395.136778115502, 5467.917981230285, 5494.835154945358, 5545.750441230144, 4928.679635823669, 4986.900261994758, 4988.850334489953, 4990.500949904998, 5080.110980578403, 4979.10376132296, 5037.697738135706, 5044.117279476095, 5044.596432285409, 5103.464136265694, 4866.075445665348, 5030.044291584587, 5062.620303477235, 5098.6685865419, 5104.285400043997, 4885.2916327132725, 4923.064617722621, 4945.802167913279, 4976.402831660224, 5033.521815427565, 4839.959408727141, 4844.491328410501, 4867.415910090812, 4869.391326084239, 4938.209886418156, 5325.334333208349, 5349.786008559653, 5372.57019438444, 5410.08028635129, 5425.647332923348, 5728.627639203439, 5786.218860453827, 5805.477507024388, 5810.041343178371, 5816.272965879265, 5841.357450680422, 5867.882642347172, 5885.4997325227405, 5893.793717219876, 5910.497607703351, 5323.733813309319, 5372.57019438444, 5452.536534394581, 5469.0, 5492.038893193715, 5953.583249172603, 5959.0763431668165, 5983.910241346383, 6015.187949626745, 6119.571629985859, 5796.88406231873, 5810.302763668386, 5811.941880581225, 5816.709164541756, 5821.679807610622, 5692.7722891083895, 5873.500752436005, 5881.235439392852, 5886.587938844325, 5894.557908156819, 5560.610757247035, 5676.517496012802, 5719.685417302088, 5746.367899531048, 5787.797427090116, 5790.942090579125, 5792.131180322901, 5795.623284486495, 5797.710114494258, 5799.652020878761, 4388.407564978751, 4419.535948725402, 4424.491183513873, 4427.291633338715, 4427.889302767392, 3975.0, 3986.9003274917777, 4003.039270575099, 4011.859584914572, 4019.3569028955226, 5469.753861076261, 5493.2034854945805, 5509.531689806411, 5517.310336207974, 5524.06090964529, 5814.94185058144, 5822.563307751935, 5829.795957141479, 5861.062230043172, 5890.2342695449315, 5568.415316391802, 5594.021046316879, 5601.047821870292, 5614.354349249807, 5706.914396284059, 4935.950640493621, 4936.654434189572, 4976.850694479099, 4996.275540046746, 5023.497650234947, 5784.913226301609, 5896.734646940812, 5937.139114828326, 5984.371640977722, 6069.605475644069, 5897.439743224387, 5905.232319798399, 5912.46787789101, 5939.049752039653, 5957.434043765836, 5957.731902064331, 5998.430149135826, 6002.309734380602, 6013.158157857816, 6029.0, 5612.045952188057, 5662.150677398423, 5740.512056475246, 5747.252857128547, 5771.7979870706, 5820.912686309624, 5948.970255148696, 5953.464188223081, 6004.399560044136, 6024.307204671343, 5759.424057594207, 5760.337561180518, 5765.365809760839, 5773.91339129905, 5774.711264436845, 5537.640053396516, 5539.086050801573, 5743.942560574341, 5766.538676905921, 5787.9421205789085, 5652.463016013472, 5655.802046928337, 5665.0, 5702.258706368146, 5704.743286552032, 5708.971455142698, 5715.0, 5748.6838223898085, 5754.424557544212, 5764.0, 5490.91763623538, 5650.660960342392, 5654.6889921054735, 5661.915071273852, 5665.065264231521], "value": 5378.874296888952, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.2779432910728, 586.0564491169218, 601.1553766957425, 608.2245137449754, 629.6725702634633, 41486.585134148685, 42393.57606423935, 42573.574264257346, 45656.0, 45731.31403028957, 42780.35829462553, 43615.563844361626, 43671.78164109175, 43762.56237437625, 43791.34312985308, 8758.86861697075, 8895.510746908918, 8897.955510222473, 8898.37711360205, 8913.0, 8726.214640682338, 8739.650413983465, 8773.912260877405, 8775.605097770616, 8814.603342849556, 8778.0, 8839.07189745074, 8861.936567611896, 8891.822163556724, 8913.866292005625, 8720.084391138935, 8784.12158784123, 8864.601092950832, 8891.555422228863, 8892.510911899843, 8584.785380365542, 8649.65401383944, 8660.610272537751, 8677.349198810052, 8684.348673849487, 41107.58892411068, 41321.0, 41371.7931410344, 41466.0, 41487.170256595, 3352.195473086466, 3355.9664403355896, 3427.057559171223, 3464.0993341731078, 3847.7883716395586, 29993.250168745955, 31736.523952140506, 32226.0, 32559.51160732591, 33412.16469588255, 4256.361545768129, 4344.695871289011, 4402.697976517612, 4532.7053741507025, 4591.724496530219, 315837.0, 316407.0, 317080.0, 317305.0, 317661.0, 58098.0, 58129.0, 58579.70710146422, 58633.70683146557, 58654.706726466946, 61291.693541532004, 61367.693161533905, 61413.38586614166, 61523.0, 61601.383986160465, 16947.91526042362, 17087.060211688477, 17166.39917602878, 17203.22585483656, 17223.827761722223, 13050.869491304966, 13069.0, 13110.868891311156, 13155.342232888317, 13155.53955611549, 18026.746656667918, 18227.71648662563, 18429.26282948667, 18634.34779782701, 18741.90629046846, 6927.238003819576, 7095.467839912028, 7184.281571842878, 7382.261773822682, 7434.368078713262, 975.6390135649855, 1018.6791160784329, 1097.5719469406938, 1114.7714718482691, 1125.5272785430138, 31146.532802007987, 31536.526952095737, 31561.36877262442, 31672.208194795316, 31707.841460792548, 1025.1286406554518, 1075.7756948131491, 1111.6710491520253, 1172.1443346357207, 1197.3175290084569, 15042.924785376223, 16000.599985000235, 16206.594835129215, 16209.270582823801, 16835.663286734198, 460678.0, 463957.0, 464859.0, 465455.0, 465643.07676924363, 57170.0, 57385.13922291169, 57702.71148644314, 57972.710136449045, 57998.7100064497, 1345.132389608697, 1356.2879488268738, 1360.6530334764573, 1385.9999999999798, 1394.079907261223, 29799.55300670535, 30571.694283056884, 31509.527357089202, 31570.684293156773, 31572.684273156974, 47334.0, 47964.280535791295, 48053.75973120112, 48075.27887081627, 48145.75927120342, 394507.0, 396143.0, 397177.0, 398376.0, 398913.0, 26935.299162671654, 27338.45323093567, 27480.862595686893, 27506.449871002867, 27605.30986725348, 44927.32609010802, 45194.0, 45824.08351832878, 46411.0, 46953.0, 38835.61164388433, 38838.80580597079, 39777.0, 40896.1820763589, 41025.384619231336, 38922.416163758135, 39592.40611390774, 39655.60344396519, 39698.60301397065, 40660.510831037434, 38996.0, 40156.39765403463, 40306.79846600748, 40351.0, 40392.596074038884, 29533.409331813673, 33626.0, 34738.65261347354, 35175.47236791501, 35401.645983539835, 27038.594421084093, 27170.1848944532, 27242.0, 27416.314592135357, 27577.0], "value": 19690.437282288713, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.3559609673312, 378.71028663072747, 379.14313651148404, 390.07746679103894, 398.09433538699454, 17398.0, 19191.520211994706, 19293.421197364067, 19370.806291937075, 19455.416337509898, 15808.604784880385, 16166.434174803884, 16537.751933720974, 16584.751228731548, 16597.41909033184, 5533.280673512448, 5787.450192231731, 5795.739191736361, 5802.53579713624, 5825.5048320892565, 5464.562834973212, 5701.0878259478495, 5739.0, 5748.626339287954, 5764.365919748824, 5672.546196304285, 5690.459406356389, 5705.144228365737, 5734.483896449318, 5749.856253593673, 5487.149491828753, 5750.971245143768, 5832.56255780816, 5853.970730146365, 5917.053271476543, 5523.199136125279, 5660.235868157828, 5683.630564013326, 5691.971540142315, 5788.507976821975, 13268.800967985488, 13482.595522134352, 13519.932400337935, 13557.525486607921, 18148.727769083474, 2127.914883404662, 2192.2984644913477, 2221.7000704904794, 2402.303332033708, 2441.987790061056, 9480.857787133198, 9531.52342382885, 9547.474888881108, 9710.854337184948, 10579.471026448648, 1645.7860478137766, 1692.82225366336, 1705.684448377042, 1720.2946791815295, 1795.4972607669874, 74709.0, 75129.62435187843, 76500.61749691272, 76715.0, 76808.99999999945, 10256.641017564349, 10501.422421766723, 10679.946600267105, 10802.297850639683, 11083.057940075023, 14987.32557034936, 15043.774343384857, 15057.472988445352, 15061.924690376478, 15085.094894306376, 7548.698052077855, 7896.807136813641, 7980.162082981319, 8055.5972201389695, 8186.54973976437, 7475.476716629783, 7492.550446973199, 7546.773596792105, 7723.7682869514, 7806.1413244543055, 4414.9558504414545, 4472.59746622799, 4474.888127796766, 4651.62786977041, 4764.71293778988, 1921.28912302449, 1923.7210604462275, 1934.0312620128036, 1981.128303546435, 2033.5119571303076, 391.64947372101807, 395.5372214508974, 1011.0647650922867, 1047.7747284333905, 1048.5596049659162, 10484.475776211159, 10549.789004219872, 11217.831732524019, 11467.08263338931, 11564.306141631529, 416.6729117642636, 422.66398213420405, 428.9828406863753, 431.2733044819489, 432.9458817647794, 6054.3945605439985, 6056.757729690763, 6180.6600636965395, 6257.8748425031245, 6409.455196308366, 261297.0, 263882.0, 264053.0, 264095.0, 294918.0, 72203.63898180581, 91431.54284228536, 92324.0, 92819.0, 93825.0, 424.73241857629495, 439.3892489439618, 439.56263517799357, 439.7493428745584, 440.07144924209894, 10280.794384112425, 10303.175745940456, 10567.94716026415, 10576.259661823598, 10613.787724245627, 29463.852680736458, 29516.409671806014, 40202.0, 40363.0, 41801.581984180986, 50103.0, 50169.24746128738, 55253.1712024328, 56369.0, 58544.0, 8136.430449868452, 8439.409241353047, 8469.407141500036, 8491.787705307417, 8918.331125165509, 10889.945550272198, 13250.933745331597, 13290.933545332598, 13363.732725345244, 13555.0, 11794.0, 11917.76164476723, 11982.940085299517, 12035.578754743541, 12100.213486123374, 11344.659660209876, 11418.0, 11664.066874649838, 11678.416079196177, 11795.0, 11761.764764704829, 12027.097967652637, 12139.514419423123, 12314.399128113288, 12350.691232718895, 8282.917170828456, 8441.62003224871, 8582.82834343322, 8622.741317760227, 8639.883228609031, 11084.501197446296, 11550.306981581132, 11617.186796924134, 11664.88335116638, 11816.822747658964], "value": 7925.034325684479, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.1373389700075, 1493.9253037348133, 1631.3882294139698, 1743.9128043597832, 1748.9038102904344, 7007.789766307019, 7276.745313914014, 7743.070831500221, 8231.794205144866, 8237.0, 7795.571243581615, 8063.677452901877, 8065.677372905091, 8239.299659528931, 8248.298894593952, 2145.9463513412134, 2148.130007347027, 2162.956740865182, 2177.052981952848, 2182.028997096285, 2187.748408932969, 2225.2322948582714, 2284.257616274709, 2289.2102224732525, 2291.598970180212, 2097.5490269592033, 2106.189117189885, 2110.45128266651, 2117.6717608770664, 2127.2979916627555, 2019.2932473634185, 2048.2216757632154, 2048.23191303262, 2048.9692654610194, 2050.4976280811147, 2157.2665293800183, 2177.3250292409402, 2195.1438938813876, 2195.2645863635703, 2198.8021078103047, 8018.077921039038, 8113.0, 8172.836543269161, 8228.0, 8239.423240373177, 4691.7654117294, 4809.975950120262, 4837.4920633333695, 4857.319975203474, 4859.052484765472, 3147.0, 3388.728901687859, 3395.8811441599423, 3396.3716712408036, 3412.9146771330666, 1048.6749107776614, 1084.8752393474772, 1140.8573928258968, 1148.9482973266222, 1155.83240430138, 10937.726556836144, 11047.72380690481, 11115.888841111648, 11140.442977851075, 11230.550777968952, 4263.360495925636, 4467.30756732707, 4495.617872480876, 4602.792874320664, 4604.631629469634, 9254.305927055499, 9348.345615806827, 9373.578188981512, 9376.156145946898, 9381.43711377306, 5066.645334826527, 5079.568236699922, 5090.898182036339, 5095.566876815438, 5114.207297868837, 4087.5912408758886, 4416.84541041062, 4583.0, 4643.303504474288, 4652.720836749806, 3743.5320584926885, 3754.9812250939117, 3765.4728338032696, 3767.962320376761, 3839.9616003840165, 1231.9199252048768, 1238.2817965579943, 1241.453760345445, 1247.650657815813, 1254.0406588959454, 863.9827203455895, 965.1458459263603, 972.1785091597731, 978.3396207559869, 1007.496251874063, 5528.198411230349, 5594.552435805126, 5643.633163844337, 5809.680467574324, 5843.474087332161, 413.2891426746052, 420.09050405871557, 422.6787641392564, 432.5199029077721, 439.5977680422442, 3649.8357573908706, 3720.9441858372147, 3754.4931434256027, 3754.6245375462236, 3890.7860067695983, 9569.425834449956, 9901.108900199017, 9906.900930990598, 9917.15704165154, 10001.599936002624, 9142.725718228463, 9755.951220243853, 9797.06927841854, 9914.702558923243, 9988.550515226687, 7176.820579485555, 7503.9624801876735, 7537.133229678548, 7554.962225188949, 7587.127480339721, 5469.535089517435, 5626.409227031103, 5688.061469857593, 5720.3421606515785, 5839.708014599338, 9113.817723645623, 9142.177204051668, 9167.12912273333, 9245.768855778659, 9252.583633736633, 8682.262007729161, 9022.368434209804, 9103.544822758968, 9225.953870230605, 9238.353315267866, 6690.69891854858, 6834.521583489108, 6901.447884169354, 7103.82240443993, 7260.564366138048, 7680.731174409092, 7724.575148366894, 7736.226377362219, 7737.226277372218, 7755.650995705094, 6665.300143484864, 6790.898136528055, 6792.286809885089, 6884.862302754017, 7104.183018952886, 6591.945288753776, 6597.241317248386, 6608.4382827458285, 6628.933710662832, 6656.467482601477, 6182.907256391248, 6261.186045814015, 6431.163948686641, 6473.320301368477, 6493.448056915026, 4746.715197088186, 4783.282507623884, 4786.779371260306, 4804.159272127434, 4873.731944742932, 4898.118338699069, 4961.404631444249, 4961.751912404293, 5026.4973502649445, 5051.191809310492], "value": 4234.826764369929, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.37634805695154, 330.3920785754212, 338.0500792772309, 341.44344718109477, 342.8611412377988, 5487.6981766002855, 5583.441655834415, 5656.547476201904, 5703.743331550085, 5723.828285151447, 5346.866328341794, 5476.644018138818, 5521.806736764214, 5540.972295138518, 5561.860953476165, 4333.436653235083, 4364.563543645641, 4364.67264955128, 4365.2142614329405, 4385.978070109645, 4102.548719640837, 4289.635380992604, 4305.913881722364, 4314.158739045887, 4352.630026447756, 4251.149770046003, 4255.63827074699, 4277.337012763011, 4288.785560721967, 4297.226499230137, 4263.957360426402, 4267.679924005696, 4303.849365272232, 4306.720063195882, 4333.58830911063, 3554.9512893696165, 3792.772433653962, 3793.7534060285993, 3793.905152371185, 3797.810109494514, 5308.761105750251, 5324.467553244684, 5346.219965617857, 5352.437994010612, 5375.3280839895015, 4891.706497610155, 4892.461829198785, 4906.950930490721, 4940.89905378535, 4947.975260123712, 5618.073017952033, 5754.3094828620415, 5755.539556835485, 5761.481466667978, 5777.908818781932, 4065.2072845795083, 4068.9186216275507, 4072.9796351018354, 4080.489938757655, 4081.3877918312196, 5951.732172052225, 6040.335563088057, 6051.848703782397, 6067.453929146398, 6076.726547305382, 3963.326234540135, 4112.588741125924, 4170.687198460128, 4189.832406703697, 4207.948012996751, 4201.6008479194425, 4243.830246790156, 4244.342126970325, 4256.170046840898, 4258.297380932174, 4867.3915760529935, 4886.413630364379, 4912.459629440758, 4919.852404427873, 4936.0, 5606.196901549225, 5730.856728581735, 5848.912266316009, 5899.351071382144, 5940.376260492672, 1501.647112928461, 1509.7056074065451, 1510.4562357551272, 1511.3425659838006, 1516.5753588995099, 948.7201275623707, 956.2493442647627, 956.6460409648474, 960.2701946520694, 988.211337479165, 4989.750512474362, 4994.0, 5004.499550044967, 5034.709207310665, 5053.873653158627, 5197.350331208599, 5287.430984085804, 5321.361436627552, 5355.179239058739, 5377.327834020747, 4976.552110310089, 4999.725015124203, 5001.799928002912, 5356.651817631841, 5739.311282646026, 3187.2828613561765, 3189.473736833443, 3202.407554602406, 3209.8876539321013, 3218.1471909943884, 6077.6353418795015, 6204.224471941007, 6237.937620623827, 6275.274299567564, 6298.685065746694, 5984.371640977722, 6036.3360030396625, 6042.969785151046, 6066.878662426727, 6150.200473938359, 6131.325554189036, 6158.938410615926, 6171.814845554551, 6248.968755156286, 6300.810975670737, 5900.967330717193, 5947.286325640951, 5963.970180149072, 5987.191729116687, 6099.79760625675, 5916.852078698067, 5940.762369505172, 5980.880382392241, 5985.760569577168, 5991.850203744767, 6034.366391528826, 6221.191245138103, 6238.845813524513, 6265.780697675559, 6275.497960163085, 4138.875833724993, 4197.643200328006, 4218.873433796991, 4227.788610569521, 4233.470816147981, 5977.983742763654, 5987.742574059496, 6025.216721826135, 6032.8793424132145, 6051.394860513913, 5585.910747404218, 5869.4717475427415, 5913.881722365442, 5927.4665280125, 5956.255468066492, 5894.941050589611, 5939.673317967553, 5939.881202375842, 5957.3744756799915, 5960.850978725566, 5688.402717714746, 5899.764009439575, 5947.375525569752, 5955.166276721176, 5975.581709280309, 5841.1238314253205, 5853.795117170878, 5854.121881717776, 5890.3226128994, 5914.585978981602, 5805.94194058054, 5806.2451881255165, 5828.794163210133, 5837.620554663933, 5845.41545845429], "value": 4399.777233429158, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.1911459165733, 761.7752762934936, 764.7055883484857, 780.785284046887, 807.5881300536724, 13316.334183290834, 13951.581452556415, 13958.651033724162, 13964.0, 14031.438742450302, 13016.934915325433, 13163.47346106157, 13186.802197967014, 13199.34003299836, 13215.074944753847, 788.8067423481241, 799.856025915335, 802.6548584108831, 808.1393316118345, 809.5749731391008, 804.6499772598909, 812.3744716568239, 814.1939479914871, 815.2092470303796, 815.5881279953616, 841.7558907916697, 845.750503601439, 846.9237768600825, 851.3444647621328, 851.9062903080656, 842.5702891525335, 842.7724514381114, 848.8769128476337, 850.090403268503, 851.5742128935532, 620.6369273974731, 623.5011990407701, 625.9812205633838, 626.614632001316, 626.9937300626981, 11805.291682499077, 11818.704532386673, 11849.585264515701, 11862.762744745056, 11904.464299106561, 10911.945440272828, 11125.666230013032, 11160.888391116147, 11454.026407755267, 11490.540378384854, 10285.794284114276, 10359.689209323733, 10452.477376131239, 10472.633457829015, 10501.4224217668, 3590.9281814363567, 3594.8741794037346, 3679.816009199529, 3804.8287827047848, 3835.520559930009, 66692.33307666909, 66912.99999999952, 67178.0, 68246.0, 68699.3130068698, 8678.479291242546, 8735.825283494294, 9005.189532942066, 9121.863172052424, 9338.299627527827, 18955.24179032851, 19094.71357929632, 19151.233950642098, 19336.03319834003, 19389.80610193908, 7114.430845532345, 7119.644017799193, 7139.0, 7315.158756743042, 7429.665665045086, 4314.503832059353, 4373.759443230653, 4375.6280716138845, 4401.383806267125, 4424.778761061934, 3269.509573563937, 3400.2009527760956, 3409.1817963688536, 3409.1988382730037, 3427.3145370925417, 513.5301199402579, 517.2603177456274, 521.0932976620653, 531.224412357954, 534.3320848938827, 695.4957655699577, 697.1390332938817, 697.9476539259474, 711.4735096028901, 722.1550785580883, 8818.603162857687, 8907.599158037903, 9236.0, 9305.720828375159, 9396.436213827192, 586.9295684517886, 622.4180391334118, 657.6974591687878, 673.3266733266734, 695.3602685529326, 4192.622663960258, 4196.748195108304, 4433.179861725591, 4506.842260520932, 4534.977325113353, 54963.0, 81367.593162035, 87673.56163219143, 94095.52952235332, 96192.9378121511, 46797.76601117041, 48258.75870620694, 55112.0, 62753.372466275665, 70104.6494767523, 50599.74700126476, 61144.69427652922, 61320.38679613147, 62347.0, 62916.68541657354, 8871.379003469696, 9724.9027509724, 9760.559860034991, 9768.560414781494, 9805.1175394212, 43025.56974430341, 43401.34897976596, 43841.123177535635, 44372.202778925515, 44524.55475445204, 54843.0, 60204.698976504835, 61343.693281535096, 61625.0, 63409.682951584946, 10180.898191017995, 10449.425281609585, 12334.444949977093, 12456.439460224494, 13007.0, 11140.832887506856, 11430.714232144262, 13878.167309961435, 14196.432142714175, 14696.55910322692, 12278.263304201777, 12849.935750321189, 13336.0, 13614.319284035957, 14004.439822407398, 12869.871301287241, 12901.161424507378, 12961.805572916226, 13399.799003015158, 13886.166829990232, 12832.165909215872, 12875.80686289725, 13334.933325333312, 13787.103838250481, 13889.166650001032, 9973.750656233653, 10487.906067709891, 10603.483959126055, 10619.30974486656, 10738.570457181626, 8731.956340218258, 9566.572436044744, 10013.849792252977, 10109.443980580845, 10791.730206744895], "value": 6732.758436302865, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 114.0, 114.0, 114.0, 115.0, 113.0, 115.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 124.0, 135.0, 172.0, 127.0, 132.0, 127.0, 124.0, 151.0, 125.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 166.0, 166.0, 167.0, 165.0, 166.0, 164.0, 162.0, 165.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 110.0, 77.0, 76.0, 76.0, 76.0, 100.0, 78.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 115.0, 83.0, 82.0, 83.0, 104.0, 82.0, 82.0, 113.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 146.0, 148.0, 155.0, 148.0, 148.0, 146.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 86.0, 85.0, 85.0, 86.0, 86.0, 86.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 58.0, 56.0, 55.0, 57.0, 58.0, 60.0, 57.0, 54.0, 54.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 64.0, 62.0, 62.0, 62.0, 62.0, 61.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 89.0, 80.0, 87.0, 81.0, 80.0, 85.0, 81.0, 90.0, 81.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 131.0, 141.0, 138.0, 145.0, 147.0, 142.0, 136.0, 179.0, 140.0], "value": 144.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 167.0, 174.0, 170.0, 167.0, 176.0, 165.0, 168.0, 167.0], "value": 169.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 72.0, 67.0, 66.0, 66.0, 67.0, 68.0, 66.0, 67.0, 65.0], "value": 68.1, "unit": "score"}]}]} 12:51:31 INFO - Return code: 0 12:51:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:51:31 ERROR - # TBPL SUCCESS # 12:51:31 INFO - Running post-action listener: _resource_record_post_action 12:51:31 INFO - [mozharness: 2016-10-27 19:51:31.156580Z] Finished run-tests step (success) 12:51:31 INFO - Running post-run listener: _resource_record_post_run 12:51:31 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393424896; Read time: 224; Write time: 409972 12:51:31 INFO - TinderboxPrint: CPU usage
13.4% 12:51:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 224 12:51:31 INFO - TinderboxPrint: I/O write bytes / time
393,424,896 / 409,972 12:51:31 INFO - TinderboxPrint: CPU idle
8,262.7 (86.6%) 12:51:31 INFO - TinderboxPrint: CPU user
1,218.7 (12.8%) 12:51:31 INFO - TinderboxPrint: Swap in / out
0 / 0 12:51:31 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106057728; Read time: 0; Write time: 167036 12:51:31 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286830592; Read time: 224; Write time: 242836 12:51:31 INFO - Running post-run listener: _upload_blobber_files 12:51:31 INFO - Blob upload gear active. 12:51:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:51:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:51:31 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:51:31 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:51:32 INFO - (blobuploader) - INFO - Open directory for files ... 12:51:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:51:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:51:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:51:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:51:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:51:35 INFO - (blobuploader) - INFO - Done attempting. 12:51:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:51:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:51:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:51:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:51:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:51:36 INFO - (blobuploader) - INFO - Done attempting. 12:51:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:51:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:51:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:51:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:51:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:51:36 INFO - (blobuploader) - INFO - Done attempting. 12:51:36 INFO - (blobuploader) - INFO - Iteration through files over. 12:51:36 INFO - Return code: 0 12:51:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:51:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:51:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5bc9d043a3666e956b301e6f4dcd7412c242e425dc2b051f44f9e86add7cd3a14adf7a1da7f8432714173f1ceaf7dc16c7d2f53696e3019340abbf54441ec37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5d25bffdaf08a1ac14050a67674cde658cb0583a9258ef491ec6ad61ae5d89a7e28a4a5e7b7b9249f9e1cd0bf0428618029336a9d414e4f73f5351cd8a0c027", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/401407dd5df3e2a54059a304f1b9a50d13747a16979ac5cdbd58eb007703148b2246fb15e8f59fbcca034d2b09ab196730ead7ff318550d9c1f5bb60f0b1bc1c"} 12:51:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:51:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:51:36 INFO - Contents: 12:51:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5bc9d043a3666e956b301e6f4dcd7412c242e425dc2b051f44f9e86add7cd3a14adf7a1da7f8432714173f1ceaf7dc16c7d2f53696e3019340abbf54441ec37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5d25bffdaf08a1ac14050a67674cde658cb0583a9258ef491ec6ad61ae5d89a7e28a4a5e7b7b9249f9e1cd0bf0428618029336a9d414e4f73f5351cd8a0c027", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/401407dd5df3e2a54059a304f1b9a50d13747a16979ac5cdbd58eb007703148b2246fb15e8f59fbcca034d2b09ab196730ead7ff318550d9c1f5bb60f0b1bc1c"} 12:51:36 INFO - Running post-run listener: copy_logs_to_upload_dir 12:51:36 INFO - Copying logs to upload dir... 12:51:36 INFO - mkdir: /builds/slave/test/build/upload/logs 12:51:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.956632 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-27 12:51:36.497706) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 12:51:36.501947) ========= 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=5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5bc9d043a3666e956b301e6f4dcd7412c242e425dc2b051f44f9e86add7cd3a14adf7a1da7f8432714173f1ceaf7dc16c7d2f53696e3019340abbf54441ec37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5d25bffdaf08a1ac14050a67674cde658cb0583a9258ef491ec6ad61ae5d89a7e28a4a5e7b7b9249f9e1cd0bf0428618029336a9d414e4f73f5351cd8a0c027", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/401407dd5df3e2a54059a304f1b9a50d13747a16979ac5cdbd58eb007703148b2246fb15e8f59fbcca034d2b09ab196730ead7ff318550d9c1f5bb60f0b1bc1c"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5bc9d043a3666e956b301e6f4dcd7412c242e425dc2b051f44f9e86add7cd3a14adf7a1da7f8432714173f1ceaf7dc16c7d2f53696e3019340abbf54441ec37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5d25bffdaf08a1ac14050a67674cde658cb0583a9258ef491ec6ad61ae5d89a7e28a4a5e7b7b9249f9e1cd0bf0428618029336a9d414e4f73f5351cd8a0c027", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/401407dd5df3e2a54059a304f1b9a50d13747a16979ac5cdbd58eb007703148b2246fb15e8f59fbcca034d2b09ab196730ead7ff318550d9c1f5bb60f0b1bc1c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 12:51:36.526940) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 12:51:36.527270) ========= 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=5bd038846534b2fdfa68eeae000001e2-1477596657.864820-113067068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 12:51:36.612245) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 12:51:36.612572) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 12:51:36.612860) ========= ========= Total master_lag: 0.17 =========