builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1471630016.4 results: success (0) buildid: 20160819095522 builduid: cb62e15829234a60b138658834426601 revision: 8ef9629d8f90d6507b1bad01146b14101de79174 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 11:06:56.398574) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 11:06:56.399017) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 11:06:56.399304) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 11:06:56.414309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:06:56.414579) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-19 11:06:57-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2016-08-19 11:06:57 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088313 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:06:56.516593) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:06:56.516900) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020551 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:06:56.566848) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:06:56.567210) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8ef9629d8f90d6507b1bad01146b14101de79174 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8ef9629d8f90d6507b1bad01146b14101de79174 --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=6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-19 11:06:57,261 truncating revision to first 12 chars 2016-08-19 11:06:57,262 Setting DEBUG logging. 2016-08-19 11:06:57,262 attempt 1/10 2016-08-19 11:06:57,262 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8ef9629d8f90?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 11:06:57,564 unpacking tar archive at: mozilla-central-8ef9629d8f90/testing/mozharness/ program finished with exit code 0 elapsedTime=0.609975 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:06:57.190782) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 11:06:57.191110) ========= script_repo_revision: 8ef9629d8f90d6507b1bad01146b14101de79174 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 11:06:57.191480) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 11:06:57.191738) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 11:06:57.200623) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-19 11:06:57.200884) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:06:57 INFO - MultiFileLogger online at 20160819 11:06:57 in /builds/slave/test 11:06:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:06:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:06:57 INFO - {'append_to_log': False, 11:06:57 INFO - 'base_work_dir': '/builds/slave/test', 11:06:57 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:06:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:06:57 INFO - 'branch': 'Firefox-Non-PGO', 11:06:57 INFO - 'buildbot_json_path': 'buildprops.json', 11:06:57 INFO - 'config_files': ('talos/linux_config.py',), 11:06:57 INFO - 'default_actions': ('clobber', 11:06:57 INFO - 'read-buildbot-config', 11:06:57 INFO - 'download-and-extract', 11:06:57 INFO - 'populate-webroot', 11:06:57 INFO - 'create-virtualenv', 11:06:57 INFO - 'install', 11:06:57 INFO - 'run-tests'), 11:06:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:06:57 INFO - 'download_minidump_stackwalk': True, 11:06:57 INFO - 'download_symbols': 'ondemand', 11:06:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:06:57 INFO - 'tooltool.py': '/tools/tooltool.py', 11:06:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:06:57 INFO - '/tools/misc-python/virtualenv.py')}, 11:06:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:06:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:06:57 INFO - 'installer_path': 'installer.exe', 11:06:57 INFO - 'log_level': 'info', 11:06:57 INFO - 'log_name': 'talos', 11:06:57 INFO - 'log_to_console': True, 11:06:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:06:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:06:57 INFO - 'opt_config_files': (), 11:06:57 INFO - 'pip_index': False, 11:06:57 INFO - 'sps_profile': False, 11:06:57 INFO - 'sps_profile_interval': 0, 11:06:57 INFO - 'suite': 'dromaeojs', 11:06:57 INFO - 'system_bits': '32', 11:06:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:06:57 INFO - 'title': 'talos-linux64-ix-023', 11:06:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:06:57 INFO - 'use_talos_json': True, 11:06:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:06:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:06:57 INFO - 'work_dir': 'build'} 11:06:57 INFO - [mozharness: 2016-08-19 18:06:57.995530Z] Running clobber step. 11:06:57 INFO - Running pre-action listener: _resource_record_pre_action 11:06:57 INFO - Running main action method: clobber 11:06:57 INFO - rmtree: /builds/slave/test/build 11:06:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:06:58 INFO - Running post-action listener: _resource_record_post_action 11:06:58 INFO - [mozharness: 2016-08-19 18:06:58.493298Z] Finished clobber step (success) 11:06:58 INFO - [mozharness: 2016-08-19 18:06:58.493399Z] Running read-buildbot-config step. 11:06:58 INFO - Running pre-action listener: _resource_record_pre_action 11:06:58 INFO - Running main action method: read_buildbot_config 11:06:58 INFO - Using buildbot properties: 11:06:58 INFO - { 11:06:58 INFO - "project": "", 11:06:58 INFO - "product": "firefox", 11:06:58 INFO - "script_repo_revision": "production", 11:06:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 11:06:58 INFO - "repository": "", 11:06:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 11:06:58 INFO - "buildid": "20160819095522", 11:06:58 INFO - "pgo_build": "False", 11:06:58 INFO - "basedir": "/builds/slave/test", 11:06:58 INFO - "buildnumber": 598, 11:06:58 INFO - "slavename": "talos-linux64-ix-023", 11:06:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:06:58 INFO - "platform": "ubuntu64_hw", 11:06:58 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 11:06:58 INFO - "branch": "mozilla-central", 11:06:58 INFO - "repo_path": "mozilla-central", 11:06:58 INFO - "revision": "8ef9629d8f90d6507b1bad01146b14101de79174", 11:06:58 INFO - "stage_platform": "linux64", 11:06:58 INFO - "builduid": "cb62e15829234a60b138658834426601", 11:06:58 INFO - "slavebuilddir": "test" 11:06:58 INFO - } 11:06:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:06:58 INFO - Running post-action listener: _resource_record_post_action 11:06:58 INFO - [mozharness: 2016-08-19 18:06:58.495839Z] Finished read-buildbot-config step (success) 11:06:58 INFO - [mozharness: 2016-08-19 18:06:58.495928Z] Running download-and-extract step. 11:06:58 INFO - Running pre-action listener: _resource_record_pre_action 11:06:58 INFO - Running main action method: download_and_extract 11:06:58 INFO - mkdir: /builds/slave/test/build/tests 11:06:58 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')]} 11:06:58 INFO - trying https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:06:58 INFO - Downloading https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:06:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:06:59 INFO - Downloaded 1361 bytes. 11:06:59 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:06:59 INFO - Using the following test package requirements: 11:06:59 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:06:59 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:06:59 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:06:59 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:59 INFO - u'jsshell-linux-x86_64.zip'], 11:06:59 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:06:59 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:06:59 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:06:59 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:06:59 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:06:59 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:06:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:06:59 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')]} 11:06:59 INFO - trying https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:06:59 INFO - Downloading https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:06:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:06:59 INFO - Downloaded 20328338 bytes. 11:06:59 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:07:04 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:07:04 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')]} 11:07:04 INFO - trying https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:07:04 INFO - Downloading https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:07:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:07:05 INFO - Downloaded 20328338 bytes. 11:07:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:09 INFO - trying https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:07:09 INFO - Downloading https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:07:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:07:10 INFO - Downloaded 14413981 bytes. 11:07:10 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 11:07: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')]} 11:07:10 INFO - trying https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:07:10 INFO - Downloading https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:07:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:07:11 INFO - Downloaded 55769195 bytes. 11:07:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:07:11 INFO - mkdir: /builds/slave/test/properties 11:07:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:07:11 INFO - Writing to file /builds/slave/test/properties/build_url 11:07:11 INFO - Contents: 11:07:11 INFO - build_url:https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:07:12 INFO - Running post-action listener: _resource_record_post_action 11:07:12 INFO - Running post-action listener: set_extra_try_arguments 11:07:12 INFO - [mozharness: 2016-08-19 18:07:12.490169Z] Finished download-and-extract step (success) 11:07:12 INFO - [mozharness: 2016-08-19 18:07:12.490393Z] Running populate-webroot step. 11:07:12 INFO - Running pre-action listener: _resource_record_pre_action 11:07:12 INFO - Running main action method: populate_webroot 11:07:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:07:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:07:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:07:12 INFO - '--tppagecycles', 11:07:12 INFO - '7'], 11:07:12 INFO - 'tests': ['tsvgm']}}, 11:07:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:07:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:07:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:07:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:07:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:07:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:07:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:12 INFO - 'talos_options': ['--disable-e10s'], 11:07:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:12 INFO - 'talos_options': ['--disable-e10s'], 11:07:12 INFO - 'tests': ['damp', 'tps']}, 11:07:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:12 INFO - 'tests': ['damp', 'tps']}, 11:07:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:07:12 INFO - 'tests': ['dromaeo_dom']}, 11:07:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:07:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:07:12 INFO - 'tests': ['basic_compositor_video']}, 11:07:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:07:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:07:12 INFO - 'tests': ['a11yr', 11:07:12 INFO - 'ts_paint', 11:07:12 INFO - 'tpaint', 11:07:12 INFO - 'sessionrestore', 11:07:12 INFO - 'sessionrestore_no_auto_restore', 11:07:12 INFO - 'tabpaint']}, 11:07:12 INFO - 'other-e10s': {'tests': ['a11yr', 11:07:12 INFO - 'ts_paint', 11:07:12 INFO - 'tpaint', 11:07:12 INFO - 'sessionrestore', 11:07:12 INFO - 'sessionrestore_no_auto_restore', 11:07:12 INFO - 'tabpaint']}, 11:07:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:07:12 INFO - 'ts_paint', 11:07:12 INFO - 'tpaint', 11:07:12 INFO - 'sessionrestore', 11:07:12 INFO - 'sessionrestore_no_auto_restore', 11:07:12 INFO - 'tabpaint']}, 11:07:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:07:12 INFO - 'ts_paint', 11:07:12 INFO - 'tpaint', 11:07:12 INFO - 'sessionrestore', 11:07:12 INFO - 'sessionrestore_no_auto_restore', 11:07:12 INFO - 'tabpaint']}, 11:07:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:07:12 INFO - 'tests': ['a11yr', 11:07:12 INFO - 'ts_paint', 11:07:12 INFO - 'tpaint', 11:07:12 INFO - 'sessionrestore', 11:07:12 INFO - 'sessionrestore_no_auto_restore', 11:07:12 INFO - 'tabpaint']}, 11:07:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:07:12 INFO - 'tests': ['a11yr', 11:07:12 INFO - 'ts_paint', 11:07:12 INFO - 'tpaint', 11:07:12 INFO - 'sessionrestore', 11:07:12 INFO - 'sessionrestore_no_auto_restore', 11:07:12 INFO - 'tabpaint']}, 11:07:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:07:12 INFO - 'tests': ['tsvgx', 11:07:12 INFO - 'tsvgr_opacity', 11:07:12 INFO - 'tart', 11:07:12 INFO - 'tscrollx', 11:07:12 INFO - 'cart']}, 11:07:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:07:12 INFO - 'tsvgr_opacity', 11:07:12 INFO - 'tart', 11:07:12 INFO - 'tscrollx', 11:07:12 INFO - 'cart']}, 11:07:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:12 INFO - 'talos_options': ['--disable-e10s'], 11:07:12 INFO - 'tests': ['tp5o']}, 11:07:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:12 INFO - 'tests': ['tp5o']}, 11:07:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:12 INFO - 'talos_options': ['--disable-e10s', 11:07:12 INFO - '--xperf_path', 11:07:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:12 INFO - 'tests': ['tp5n']}, 11:07:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:12 INFO - 'talos_options': ['--xperf_path', 11:07:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:12 INFO - 'tests': ['tp5n']}}, 11:07:12 INFO - 'talos.zip': {'path': '', 11:07:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:07:12 INFO - Running post-action listener: _resource_record_post_action 11:07:12 INFO - [mozharness: 2016-08-19 18:07:12.511571Z] Finished populate-webroot step (success) 11:07:12 INFO - [mozharness: 2016-08-19 18:07:12.511660Z] Running create-virtualenv step. 11:07:12 INFO - Running pre-action listener: _resource_record_pre_action 11:07:12 INFO - Running main action method: create_virtualenv 11:07:12 INFO - Creating virtualenv /builds/slave/test/build/venv 11:07:12 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 11:07:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:07:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:07:12 INFO - Using real prefix '/usr' 11:07:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:07:13 INFO - Installing distribute.............................................................................................................................................................................................done. 11:07:15 INFO - Installing pip.................done. 11:07:15 INFO - Return code: 0 11:07:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa623edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1727090>, '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 0x172a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172ae40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213', '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 11:07:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:07:15 INFO - Using env: {'DISPLAY': ':0', 11:07:15 INFO - 'HOME': '/home/cltbld', 11:07:15 INFO - 'LANG': 'en_US.UTF-8', 11:07:15 INFO - 'LANGUAGE': 'en_US:en', 11:07:15 INFO - 'LOGNAME': 'cltbld', 11:07:15 INFO - 'MAIL': '/var/mail/cltbld', 11:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:15 INFO - 'MOZ_NO_REMOTE': '1', 11:07:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:15 INFO - 'NO_EM_RESTART': '1', 11:07:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:15 INFO - 'PWD': '/builds/slave/test', 11:07:15 INFO - 'SHELL': '/bin/bash', 11:07:15 INFO - 'SHLVL': '1', 11:07:15 INFO - 'TERM': 'linux', 11:07:15 INFO - 'TMOUT': '86400', 11:07:15 INFO - 'USER': 'cltbld', 11:07:15 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213', 11:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:15 INFO - '_': '/tools/buildbot/bin/python'} 11:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:15 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 11:07:15 INFO - Cleaning up... 11:07:15 INFO - Return code: 0 11:07:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffa623edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1727090>, '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 0x172a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172ae40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213', '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 11:07:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:07:15 INFO - Using env: {'DISPLAY': ':0', 11:07:15 INFO - 'HOME': '/home/cltbld', 11:07:15 INFO - 'LANG': 'en_US.UTF-8', 11:07:15 INFO - 'LANGUAGE': 'en_US:en', 11:07:15 INFO - 'LOGNAME': 'cltbld', 11:07:15 INFO - 'MAIL': '/var/mail/cltbld', 11:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:15 INFO - 'MOZ_NO_REMOTE': '1', 11:07:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:15 INFO - 'NO_EM_RESTART': '1', 11:07:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:15 INFO - 'PWD': '/builds/slave/test', 11:07:15 INFO - 'SHELL': '/bin/bash', 11:07:15 INFO - 'SHLVL': '1', 11:07:15 INFO - 'TERM': 'linux', 11:07:15 INFO - 'TMOUT': '86400', 11:07:15 INFO - 'USER': 'cltbld', 11:07:15 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213', 11:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:15 INFO - '_': '/tools/buildbot/bin/python'} 11:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:15 INFO - Downloading/unpacking psutil>=3.1.1 11:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:07:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:17 INFO - Installing collected packages: psutil 11:07:17 INFO - Running setup.py install for psutil 11:07:17 INFO - building 'psutil._psutil_linux' extension 11:07:17 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 11:07:17 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 11:07:17 INFO - building 'psutil._psutil_posix' extension 11:07:17 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 11:07:17 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 11:07:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:17 INFO - Successfully installed psutil 11:07:17 INFO - Cleaning up... 11:07:18 INFO - Return code: 0 11:07:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa623edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1727090>, '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 0x172a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172ae40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213', '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 11:07:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:07:18 INFO - Using env: {'DISPLAY': ':0', 11:07:18 INFO - 'HOME': '/home/cltbld', 11:07:18 INFO - 'LANG': 'en_US.UTF-8', 11:07:18 INFO - 'LANGUAGE': 'en_US:en', 11:07:18 INFO - 'LOGNAME': 'cltbld', 11:07:18 INFO - 'MAIL': '/var/mail/cltbld', 11:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:18 INFO - 'MOZ_NO_REMOTE': '1', 11:07:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:18 INFO - 'NO_EM_RESTART': '1', 11:07:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:18 INFO - 'PWD': '/builds/slave/test', 11:07:18 INFO - 'SHELL': '/bin/bash', 11:07:18 INFO - 'SHLVL': '1', 11:07:18 INFO - 'TERM': 'linux', 11:07:18 INFO - 'TMOUT': '86400', 11:07:18 INFO - 'USER': 'cltbld', 11:07:18 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213', 11:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:18 INFO - '_': '/tools/buildbot/bin/python'} 11:07:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:07:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:07:20 INFO - Installing collected packages: mozsystemmonitor 11:07:20 INFO - Running setup.py install for mozsystemmonitor 11:07:20 INFO - Successfully installed mozsystemmonitor 11:07:20 INFO - Cleaning up... 11:07:20 INFO - Return code: 0 11:07:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:07:20 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')]} 11:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:20 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')]} 11:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:20 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 0x7ffa623edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1727090>, '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 0x172a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172ae40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213', '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 11:07:20 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 11:07:20 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 11:07:20 INFO - Using env: {'DISPLAY': ':0', 11:07:20 INFO - 'HOME': '/home/cltbld', 11:07:20 INFO - 'LANG': 'en_US.UTF-8', 11:07:20 INFO - 'LANGUAGE': 'en_US:en', 11:07:20 INFO - 'LOGNAME': 'cltbld', 11:07:20 INFO - 'MAIL': '/var/mail/cltbld', 11:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:20 INFO - 'MOZ_NO_REMOTE': '1', 11:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:20 INFO - 'NO_EM_RESTART': '1', 11:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:20 INFO - 'PWD': '/builds/slave/test', 11:07:20 INFO - 'SHELL': '/bin/bash', 11:07:20 INFO - 'SHLVL': '1', 11:07:20 INFO - 'TERM': 'linux', 11:07:20 INFO - 'TMOUT': '86400', 11:07:20 INFO - 'USER': 'cltbld', 11:07:20 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213', 11:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:20 INFO - '_': '/tools/buildbot/bin/python'} 11:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:20 INFO - Downloading/unpacking jsonschema==2.5.1 11:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:07:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07:22 INFO - Downloading functools32-3.2.3-2.tar.gz 11:07:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:07:22 INFO - warning: no files found matching '*.txt' 11:07:22 INFO - no previously-included directories found matching 'build' 11:07:22 INFO - no previously-included directories found matching 'dist' 11:07:22 INFO - no previously-included directories found matching '.git*' 11:07:22 INFO - Installing collected packages: jsonschema, functools32 11:07:22 INFO - Running setup.py install for functools32 11:07:22 INFO - warning: no files found matching '*.txt' 11:07:22 INFO - no previously-included directories found matching 'build' 11:07:22 INFO - no previously-included directories found matching 'dist' 11:07:22 INFO - no previously-included directories found matching '.git*' 11:07:22 INFO - Successfully installed jsonschema functools32 11:07:22 INFO - Cleaning up... 11:07:22 INFO - Return code: 0 11:07:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:07: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')]} 11:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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 0x7ffa623edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1727090>, '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 0x172a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172ae40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213', '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 11:07: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 11:07: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 11:07:22 INFO - Using env: {'DISPLAY': ':0', 11:07:22 INFO - 'HOME': '/home/cltbld', 11:07:22 INFO - 'LANG': 'en_US.UTF-8', 11:07:22 INFO - 'LANGUAGE': 'en_US:en', 11:07:22 INFO - 'LOGNAME': 'cltbld', 11:07:22 INFO - 'MAIL': '/var/mail/cltbld', 11:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:22 INFO - 'MOZ_NO_REMOTE': '1', 11:07:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:22 INFO - 'NO_EM_RESTART': '1', 11:07:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:22 INFO - 'PWD': '/builds/slave/test', 11:07:22 INFO - 'SHELL': '/bin/bash', 11:07:22 INFO - 'SHLVL': '1', 11:07:22 INFO - 'TERM': 'linux', 11:07:22 INFO - 'TMOUT': '86400', 11:07:22 INFO - 'USER': 'cltbld', 11:07:22 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213', 11:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:22 INFO - '_': '/tools/buildbot/bin/python'} 11:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:07:23 INFO - Cleaning up... 11:07:23 INFO - Return code: 0 11:07:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:07:23 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')]} 11:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:23 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')]} 11:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:23 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 0x7ffa623edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1727090>, '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 0x172a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172ae40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213', '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 11:07:23 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 11:07:23 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 11:07:23 INFO - Using env: {'DISPLAY': ':0', 11:07:23 INFO - 'HOME': '/home/cltbld', 11:07:23 INFO - 'LANG': 'en_US.UTF-8', 11:07:23 INFO - 'LANGUAGE': 'en_US:en', 11:07:23 INFO - 'LOGNAME': 'cltbld', 11:07:23 INFO - 'MAIL': '/var/mail/cltbld', 11:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:23 INFO - 'MOZ_NO_REMOTE': '1', 11:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:23 INFO - 'NO_EM_RESTART': '1', 11:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:23 INFO - 'PWD': '/builds/slave/test', 11:07:23 INFO - 'SHELL': '/bin/bash', 11:07:23 INFO - 'SHLVL': '1', 11:07:23 INFO - 'TERM': 'linux', 11:07:23 INFO - 'TMOUT': '86400', 11:07:23 INFO - 'USER': 'cltbld', 11:07:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213', 11:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:23 INFO - '_': '/tools/buildbot/bin/python'} 11:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:23 INFO - Downloading/unpacking blobuploader==1.2.4 11:07:23 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 11:07:23 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 11:07:23 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 11:07:23 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 11:07:23 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 11:07:23 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 11:07:25 INFO - Downloading blobuploader-1.2.4.tar.gz 11:07:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:07:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:07:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:25 INFO - Downloading docopt-0.6.1.tar.gz 11:07:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:07:25 INFO - Installing collected packages: blobuploader, requests, docopt 11:07:25 INFO - Running setup.py install for blobuploader 11:07:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:07:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:07:26 INFO - Running setup.py install for requests 11:07:26 INFO - Running setup.py install for docopt 11:07:26 INFO - Successfully installed blobuploader requests docopt 11:07:26 INFO - Cleaning up... 11:07:26 INFO - Return code: 0 11:07:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:26 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')]} 11:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:26 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')]} 11:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:26 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 0x7ffa623edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1727090>, '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 0x172a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172ae40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213', '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 11:07:26 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 11:07:26 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 11:07:26 INFO - Using env: {'DISPLAY': ':0', 11:07:26 INFO - 'HOME': '/home/cltbld', 11:07:26 INFO - 'LANG': 'en_US.UTF-8', 11:07:26 INFO - 'LANGUAGE': 'en_US:en', 11:07:26 INFO - 'LOGNAME': 'cltbld', 11:07:26 INFO - 'MAIL': '/var/mail/cltbld', 11:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:26 INFO - 'MOZ_NO_REMOTE': '1', 11:07:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:26 INFO - 'NO_EM_RESTART': '1', 11:07:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:26 INFO - 'PWD': '/builds/slave/test', 11:07:26 INFO - 'SHELL': '/bin/bash', 11:07:26 INFO - 'SHLVL': '1', 11:07:26 INFO - 'TERM': 'linux', 11:07:26 INFO - 'TMOUT': '86400', 11:07:26 INFO - 'USER': 'cltbld', 11:07:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213', 11:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:26 INFO - '_': '/tools/buildbot/bin/python'} 11:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:26 INFO - Running setup.py (path:/tmp/pip-3m7O7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:26 INFO - Running setup.py (path:/tmp/pip-1tyj8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:26 INFO - Running setup.py (path:/tmp/pip-TukV5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:26 INFO - Running setup.py (path:/tmp/pip-o49z7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:27 INFO - Running setup.py (path:/tmp/pip-DH5EiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:27 INFO - Running setup.py (path:/tmp/pip-nPf1ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:27 INFO - Running setup.py (path:/tmp/pip-NNIlpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:27 INFO - Running setup.py (path:/tmp/pip-lHZ2nR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:27 INFO - Running setup.py (path:/tmp/pip-ITHY_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:27 INFO - Running setup.py (path:/tmp/pip-f5neG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:27 INFO - Running setup.py (path:/tmp/pip-O1wYrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:27 INFO - Running setup.py (path:/tmp/pip-38ej03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:27 INFO - Running setup.py (path:/tmp/pip-AlkUBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:27 INFO - Running setup.py (path:/tmp/pip-jBELGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:27 INFO - Running setup.py (path:/tmp/pip-ShFMof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:27 INFO - Running setup.py (path:/tmp/pip-9bz5WT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:27 INFO - Running setup.py (path:/tmp/pip-6HeEzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:07:27 INFO - Running setup.py install for manifestparser 11:07:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:07:28 INFO - Running setup.py install for mozcrash 11:07:28 INFO - Running setup.py install for mozdebug 11:07:28 INFO - Running setup.py install for mozdevice 11:07:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:07:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:07:28 INFO - Running setup.py install for mozfile 11:07:28 INFO - Running setup.py install for mozhttpd 11:07:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:07:28 INFO - Running setup.py install for mozinfo 11:07:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:07:28 INFO - Running setup.py install for mozInstall 11:07:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:07:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:07:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:07:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:07:28 INFO - Running setup.py install for mozleak 11:07:28 INFO - Running setup.py install for mozlog 11:07:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:07:29 INFO - Running setup.py install for moznetwork 11:07:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:07:29 INFO - Running setup.py install for mozprocess 11:07:29 INFO - Running setup.py install for mozprofile 11:07:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:07:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:07:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:07:29 INFO - Running setup.py install for mozrunner 11:07:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:07:29 INFO - Running setup.py install for mozscreenshot 11:07:29 INFO - Running setup.py install for moztest 11:07:29 INFO - Running setup.py install for mozversion 11:07:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:07:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:07:29 INFO - Cleaning up... 11:07:29 INFO - Return code: 0 11:07:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07: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')]} 11:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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 0x7ffa623edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1727090>, '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 0x172a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172ae40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213', '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 11:07: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 11:07: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 11:07:29 INFO - Using env: {'DISPLAY': ':0', 11:07:29 INFO - 'HOME': '/home/cltbld', 11:07:29 INFO - 'LANG': 'en_US.UTF-8', 11:07:29 INFO - 'LANGUAGE': 'en_US:en', 11:07:29 INFO - 'LOGNAME': 'cltbld', 11:07:29 INFO - 'MAIL': '/var/mail/cltbld', 11:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:29 INFO - 'MOZ_NO_REMOTE': '1', 11:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:29 INFO - 'NO_EM_RESTART': '1', 11:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:29 INFO - 'PWD': '/builds/slave/test', 11:07:29 INFO - 'SHELL': '/bin/bash', 11:07:29 INFO - 'SHLVL': '1', 11:07:29 INFO - 'TERM': 'linux', 11:07:29 INFO - 'TMOUT': '86400', 11:07:29 INFO - 'USER': 'cltbld', 11:07:29 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213', 11:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:29 INFO - '_': '/tools/buildbot/bin/python'} 11:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:30 INFO - Running setup.py (path:/tmp/pip-6W2vsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:30 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)) 11:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:30 INFO - Running setup.py (path:/tmp/pip-Nwy6Gn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:30 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)) 11:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:30 INFO - Running setup.py (path:/tmp/pip-Cb3IEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:30 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)) 11:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:30 INFO - Running setup.py (path:/tmp/pip-ZjGcoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:30 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)) 11:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:30 INFO - Running setup.py (path:/tmp/pip-OgyZ9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:30 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)) 11:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:30 INFO - Running setup.py (path:/tmp/pip-n3M5Te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:30 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)) 11:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:30 INFO - Running setup.py (path:/tmp/pip-YhIme7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:30 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)) 11:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:30 INFO - Running setup.py (path:/tmp/pip-9M0S0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:30 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)) 11:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:30 INFO - Running setup.py (path:/tmp/pip-fgM9_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:30 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)) 11:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:30 INFO - Running setup.py (path:/tmp/pip-2jqUaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 11:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:30 INFO - Running setup.py (path:/tmp/pip-IAa94w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07: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)) 11:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:30 INFO - Running setup.py (path:/tmp/pip-F_2Rxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07: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)) 11:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:30 INFO - Running setup.py (path:/tmp/pip-I3y_Kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07: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)) 11:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:30 INFO - Running setup.py (path:/tmp/pip-GjpCyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:31 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)) 11:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:31 INFO - Running setup.py (path:/tmp/pip-yprC7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:31 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)) 11:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:31 INFO - Running setup.py (path:/tmp/pip-aK4TiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:31 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)) 11:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:31 INFO - Running setup.py (path:/tmp/pip-nlxSI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:31 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)) 11:07:31 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)) 11:07:31 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)) 11:07:31 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)) 11:07:31 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)) 11:07:31 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)) 11:07:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:07:31 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 11:07:31 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 11:07:31 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 11:07:31 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 11:07:31 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 11:07:31 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 11:07:33 INFO - Downloading blessings-1.6.tar.gz 11:07:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:07:33 INFO - Installing collected packages: blessings 11:07:33 INFO - Running setup.py install for blessings 11:07:33 INFO - Successfully installed blessings 11:07:33 INFO - Cleaning up... 11:07:33 INFO - Return code: 0 11:07:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:07:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:33 INFO - Reading from file tmpfile_stdout 11:07:33 INFO - Current package versions: 11:07:33 INFO - argparse == 1.2.1 11:07:33 INFO - blessings == 1.6 11:07:33 INFO - blobuploader == 1.2.4 11:07:33 INFO - docopt == 0.6.1 11:07:33 INFO - functools32 == 3.2.3-2 11:07:33 INFO - jsonschema == 2.5.1 11:07:33 INFO - manifestparser == 1.1 11:07:33 INFO - mozInstall == 1.12 11:07:33 INFO - mozcrash == 0.17 11:07:33 INFO - mozdebug == 0.1 11:07:33 INFO - mozdevice == 0.48 11:07:33 INFO - mozfile == 1.2 11:07:33 INFO - mozhttpd == 0.7 11:07:33 INFO - mozinfo == 0.9 11:07:33 INFO - mozleak == 0.1 11:07:33 INFO - mozlog == 3.3 11:07:33 INFO - moznetwork == 0.27 11:07:33 INFO - mozprocess == 0.23 11:07:33 INFO - mozprofile == 0.28 11:07:33 INFO - mozrunner == 6.12 11:07:33 INFO - mozscreenshot == 0.1 11:07:33 INFO - mozsystemmonitor == 0.3 11:07:33 INFO - moztest == 0.7 11:07:33 INFO - mozversion == 1.4 11:07:33 INFO - psutil == 3.1.1 11:07:33 INFO - requests == 1.2.3 11:07:33 INFO - wsgiref == 0.1.2 11:07:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07: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')]} 11:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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 0x7ffa623edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1727090>, '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 0x172a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172ae40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213', '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 11:07: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 11:07: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 11:07:33 INFO - Using env: {'DISPLAY': ':0', 11:07:33 INFO - 'HOME': '/home/cltbld', 11:07:33 INFO - 'LANG': 'en_US.UTF-8', 11:07:33 INFO - 'LANGUAGE': 'en_US:en', 11:07:33 INFO - 'LOGNAME': 'cltbld', 11:07:33 INFO - 'MAIL': '/var/mail/cltbld', 11:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:33 INFO - 'MOZ_NO_REMOTE': '1', 11:07:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:33 INFO - 'NO_EM_RESTART': '1', 11:07:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:33 INFO - 'PWD': '/builds/slave/test', 11:07:33 INFO - 'SHELL': '/bin/bash', 11:07:33 INFO - 'SHLVL': '1', 11:07:33 INFO - 'TERM': 'linux', 11:07:33 INFO - 'TMOUT': '86400', 11:07:33 INFO - 'USER': 'cltbld', 11:07:33 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213', 11:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:33 INFO - '_': '/tools/buildbot/bin/python'} 11:07:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:34 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)) 11:07:34 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)) 11:07:34 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)) 11:07:34 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)) 11:07:34 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)) 11:07:34 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)) 11:07:34 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)) 11:07:34 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)) 11:07:34 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)) 11:07:34 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)) 11:07:34 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)) 11:07:34 INFO - Cleaning up... 11:07:34 INFO - Return code: 0 11:07:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:34 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 0x7ffa623edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1727090>, '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 0x172a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172ae40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213', '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 11:07:34 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 11:07:34 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 11:07:34 INFO - Using env: {'DISPLAY': ':0', 11:07:34 INFO - 'HOME': '/home/cltbld', 11:07:34 INFO - 'LANG': 'en_US.UTF-8', 11:07:34 INFO - 'LANGUAGE': 'en_US:en', 11:07:34 INFO - 'LOGNAME': 'cltbld', 11:07:34 INFO - 'MAIL': '/var/mail/cltbld', 11:07:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:34 INFO - 'MOZ_NO_REMOTE': '1', 11:07:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:34 INFO - 'NO_EM_RESTART': '1', 11:07:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:34 INFO - 'PWD': '/builds/slave/test', 11:07:34 INFO - 'SHELL': '/bin/bash', 11:07:34 INFO - 'SHLVL': '1', 11:07:34 INFO - 'TERM': 'linux', 11:07:34 INFO - 'TMOUT': '86400', 11:07:34 INFO - 'USER': 'cltbld', 11:07:34 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213', 11:07:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:34 INFO - '_': '/tools/buildbot/bin/python'} 11:07:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:07:34 INFO - Cleaning up... 11:07:34 INFO - Return code: 0 11:07:34 INFO - Running post-action listener: _resource_record_post_action 11:07:34 INFO - Running post-action listener: _start_resource_monitoring 11:07:34 INFO - Starting resource monitoring. 11:07:34 INFO - [mozharness: 2016-08-19 18:07:34.284691Z] Finished create-virtualenv step (success) 11:07:34 INFO - [mozharness: 2016-08-19 18:07:34.285197Z] Running install step. 11:07:34 INFO - Running pre-action listener: _resource_record_pre_action 11:07:34 INFO - Running main action method: install 11:07:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:34 INFO - Reading from file tmpfile_stdout 11:07:34 INFO - Detecting whether we're running mozinstall >=1.0... 11:07:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:07:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:07:34 INFO - Reading from file tmpfile_stdout 11:07:34 INFO - Output received: 11:07:34 INFO - Usage: mozinstall [options] installer 11:07:34 INFO - Options: 11:07:34 INFO - -h, --help show this help message and exit 11:07:34 INFO - -d DEST, --destination=DEST 11:07:34 INFO - Directory to install application into. [default: 11:07:34 INFO - "/builds/slave/test"] 11:07:34 INFO - --app=APP Application being installed. [default: firefox] 11:07:34 INFO - mkdir: /builds/slave/test/build/application 11:07:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:07:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:07:50 INFO - Reading from file tmpfile_stdout 11:07:50 INFO - Output received: 11:07:50 INFO - /builds/slave/test/build/application/firefox/firefox 11:07:50 INFO - Running post-action listener: _resource_record_post_action 11:07:50 INFO - [mozharness: 2016-08-19 18:07:50.678666Z] Finished install step (success) 11:07:50 INFO - [mozharness: 2016-08-19 18:07:50.678925Z] Running run-tests step. 11:07:50 INFO - Running pre-action listener: _resource_record_pre_action 11:07:50 INFO - Running main action method: run_tests 11:07:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:07:50 INFO - Python 2.7.3 11:07:50 INFO - Return code: 0 11:07:50 INFO - grabbing minidump binary from tooltool 11:07: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')]} 11:07: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 0x1727090>, '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 0x172a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172ae40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:07: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 11:07: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 11:07: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 11:07:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:07:50 INFO - Return code: 0 11:07:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:07:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:07:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:07:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:07:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:07:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:07:50 INFO - Using env: {'DISPLAY': ':0', 11:07:50 INFO - 'HOME': '/home/cltbld', 11:07:50 INFO - 'LANG': 'en_US.UTF-8', 11:07:50 INFO - 'LANGUAGE': 'en_US:en', 11:07:50 INFO - 'LOGNAME': 'cltbld', 11:07:50 INFO - 'MAIL': '/var/mail/cltbld', 11:07:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:07:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:50 INFO - 'MOZ_NO_REMOTE': '1', 11:07:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:50 INFO - 'NO_EM_RESTART': '1', 11:07:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:50 INFO - 'PWD': '/builds/slave/test', 11:07:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:07:50 INFO - 'SHELL': '/bin/bash', 11:07:50 INFO - 'SHLVL': '1', 11:07:50 INFO - 'TERM': 'linux', 11:07:50 INFO - 'TMOUT': '86400', 11:07:50 INFO - 'USER': 'cltbld', 11:07:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213', 11:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:50 INFO - '_': '/tools/buildbot/bin/python'} 11:07:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:07:50 INFO - mozversion application_buildid: 20160819095522 11:07:50 INFO - mozversion application_changeset: 8ef9629d8f90d6507b1bad01146b14101de79174 11:07:50 INFO - mozversion application_display_name: Nightly 11:07:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:07:50 INFO - mozversion application_name: Firefox 11:07:50 INFO - mozversion application_remotingname: firefox 11:07:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:07:50 INFO - mozversion application_vendor: Mozilla 11:07:50 INFO - mozversion application_version: 51.0a1 11:07:50 INFO - mozversion platform_buildid: 20160819095522 11:07:50 INFO - mozversion platform_changeset: 8ef9629d8f90d6507b1bad01146b14101de79174 11:07:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:07:50 INFO - mozversion platform_version: 51.0a1 11:07:50 INFO - using testdate: 1471630070 11:07:50 INFO - actual date: 1471630070 11:07:50 INFO - starting webserver on 'localhost:40614' 11:07:50 INFO - SUITE-START | Running 2 tests 11:07:50 INFO - TEST-START | dromaeo_css 11:07:50 INFO - operating with platform_type : linux_ 11:07:50 INFO - Initialising browser for dromaeo_css test... 11:07:50 INFO - TEST-INFO | started process 24488 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpICYjMY/profile http://localhost:40614/getInfo.html) 11:07:55 INFO - PROCESS | 24488 | __metrics Screen width/height:1600/1200 11:07:55 INFO - PROCESS | 24488 | colorDepth:24 11:07:55 INFO - PROCESS | 24488 | Browser inner width/height: 1024/697 11:07:55 INFO - PROCESS | 24488 | __metrics 11:07:55 INFO - PROCESS | 24488 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:07:55 INFO - PROCESS | 24488 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:07:55 INFO - PROCESS | 24488 | console.error: PushService: 11:07:56 INFO - PROCESS | 24488 | stateChangeProcessEnqueue: Error transitioning state 11:07:56 INFO - PROCESS | 24488 | UnknownError 11:07:56 INFO - TEST-INFO | 24488: exit 0 11:07:56 INFO - Browser initialized. 11:07:56 INFO - Running cycle 1/1 for dromaeo_css test... 11:07:56 INFO - TEST-INFO | started process 24568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpICYjMY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:08:08 INFO - PROCESS | 24568 | RSS: Main: 157609984 11:08:08 INFO - PROCESS | 24568 | 11:09:00 INFO - PROCESS | 24568 | 1471630140277 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] 11:11:12 INFO - PROCESS | 24568 | Cycle 1(1): loaded http://localhost:40614/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40614/tests/dromaeo/cssquery-ext.html) 11:11:13 INFO - PROCESS | 24568 | RSS: Main: 239464448 11:11:13 INFO - PROCESS | 24568 | 11:14:16 INFO - PROCESS | 24568 | Cycle 1(1): loaded http://localhost:40614/tests/dromaeo/cssquery-ext.html (next: http://localhost:40614/tests/dromaeo/cssquery-jquery.html) 11:14:16 INFO - PROCESS | 24568 | RSS: Main: 246665216 11:14:16 INFO - PROCESS | 24568 | 11:17:18 INFO - PROCESS | 24568 | Cycle 1(1): loaded http://localhost:40614/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40614/tests/dromaeo/cssquery-mootools.html) 11:17:19 INFO - PROCESS | 24568 | RSS: Main: 187846656 11:17:19 INFO - PROCESS | 24568 | 11:20:21 INFO - PROCESS | 24568 | Cycle 1(1): loaded http://localhost:40614/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40614/tests/dromaeo/cssquery-prototype.html) 11:20:22 INFO - PROCESS | 24568 | RSS: Main: 193441792 11:20:22 INFO - PROCESS | 24568 | 11:23:25 INFO - PROCESS | 24568 | Cycle 1(1): loaded http://localhost:40614/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40614/tests/dromaeo/cssquery-yui.html) 11:23:26 INFO - PROCESS | 24568 | RSS: Main: 190132224 11:23:26 INFO - PROCESS | 24568 | 11:26:29 INFO - PROCESS | 24568 | Cycle 1(1): loaded http://localhost:40614/tests/dromaeo/cssquery-yui.html (next: http://localhost:40614/tests/dromaeo/cssquery-dojo.html) 11:26:29 INFO - PROCESS | 24568 | RSS: Main: 279678976 11:26:29 INFO - PROCESS | 24568 | 11:26:29 INFO - PROCESS | 24568 | __start_tp_report 11:26:29 INFO - PROCESS | 24568 | _x_x_mozilla_page_load 11:26:29 INFO - PROCESS | 24568 | _x_x_mozilla_page_load_details 11:26:29 INFO - PROCESS | 24568 | |i|pagename|runs| 11:26:29 INFO - PROCESS | 24568 | |0;dojo.html;2553.3361326055224;2580.4839032193568;2589.236175328278;2599.3631560267736;2602.1803132013415;4574.176648203331;4609.930851037233;4619.7921093550785;4697.835575754849;4698.694584851983;4590.862274131773;4615.953840461594;4670.97664511677;4679.15775160471;4695.2957056441555;4218.852340168095;4246.8725938221905;4321.632661223784;4360.672949528782;4364.476262848447;4346.6522678185665;4370.4099946507295;4386.32012038133;4388.86833394997;4391.494978077514;4193.433886425324;4239;4250.638695710868;4306.117245964585;4315.4605674290715;4178.498580170369;4207.158568286355;4209.179210054041;4219.2194444027955;4285.185814695198;4234.30134027885;4235.2800023996;4256.893577660552;4261.147770445892;4291.120320334324;4701.976490117561;4704.106219818258;4705.788239529229;4712.622990160813;4716.9056618867435;4865.537773911473;4895.510448955111;4938.1111399947995;4955.157623204028;5018.2974383586325;4976.601871850279;5011.098002359574;5014.52362025607;5019.7741101650145;5023.271625614302;4522.932156017662;4711.151992641289;4713.622910167179;4714.6464015199;4718.245080787126;5049.8737531562;5100.897982040338;5116.181410974226;5169.121249387538;5185.299984502044;4965.255211718199;4975.4527002029745;4976.253561965734;4981.42713587942;4996.950030499648;4818;5031.119554078022;5037.420696619935;5042.168042272984;5043.344365232496;4911.778969946361;4964.106460837084;4965.851024469272;5014.799408023711;5042.571381432546;4994.375703037121;5006.173981293119;5010.874728131753;5010.89978200434;5013.548780609763;4073.6130067643526;4257.595528424795;4259.42497762798;4259.659227261812;4272;3669.2661467706566;3725.3294407006997;3730.1607138393642;3739.4390841373465;3796.335641262768;4323.524412314643;4344.152890186447;4350.21696094706;4355.172517221781;4359.498657654347;4824.131656301829;5040.873978150502;5081.949180508148;5098.133317336062;5100;4246.617804397619;4287.335463003239;4295.119500502389;4343.891402714894;4349.043210493686;4532.1842068427995;4546.272596384562;4549.431321084864;4549.681522293407;4557.316402539579;4603;4776.2119250324;4791.209450440639;4800.591949684316;4801.303810947463;4983.501649835132;4995.775190116381;5019.171836646912;5071.880793312161;5096.592272618256;4763.880902977315;4798.04039192156;4799.448063472606;4799.928001079917;4806.543378379049;4782.163121453801;4913.901721965469;4945.085159245551;4958.281049247911;4961;4932.161532539405;4976.377952755905;5001.624878134082;5036.834843420819;5064.34163558735;4910.779014944407;4921.704697718148;4923.433805112458;4927.1131196384995;4928.457869634266;4717.150912835723;4930.211166213532;4943.629227807857;4956.430010548833;4957.107720610325;4712.787924543472;4741.83403580873;4761.119192949315;4785.808567657394;4805.549169923294;4874.147024270667;4892.2661600760175;4896.461389247252;4901.779419926183;4903.754812259444;4669.906601867876;4806.519348065165;4807.663463557517;4811.807527698853;4814 11:26:29 INFO - PROCESS | 24568 | |1;ext.html;567.6026781253124;567.920491131242;574.1502576187243;575.6977586766947;576.7865889620841;39856;41036.58963410365;41128.17743645129;44666.33000504995;44693;40433.59566404335;41009.17981640365;41024.58975410245;41110.383344249785;41112.17775644486;7425.03474548308;7634;7776.30013298803;7776.961115194416;9836.31145819793;9723.12491875731;10088.092071713545;10103.393796372204;10106.292559520836;10127.645532406368;10161.745956351077;10181.745456363577;10203.540840662188;10216.795664086714;10218.182545396388;10174.796504069951;10179.592816287377;10215;10216.489175541268;10218.18254539635;9842.753931151707;9906.504674766305;9912.405255684609;9914;9918.603255869757;38940.80529597334;39208.60791392078;39225.60774392248;39295.803520982496;39311.41032884509;3019.9094027179;3066.371393864275;3101.116181888151;3162.0197738701077;3257.4136655402017;28651.856740716372;28956;29116.41767164645;29117;30749.538756918664;3273.312604353089;3316.9170770730684;3339.699427051577;3364.3775901458066;3374.5106959490736;245391.99999999822;245778;245865;246424;247416;29205.85397073001;51994;52234;52322;52328.47671523312;30680.53979190314;30884.382312354075;30959.845200773852;31078;31113.37773244568;12016.699582510508;12226;12226.266424014588;12227.388630568435;12249.203801752858;9135.040820713863;9241;9245.306602004877;9456.716298511055;9538.093881081286;7532.209118042636;7716.382689384835;7816.765497035098;7905.169957154531;7909.683612655429;2996.3258266889775;3016.8642411091555;3027.8940237091597;3107.6115485564305;3126.906192814219;793.8491686579531;825.7027470110755;875.772299202212;901.8782464367358;949.7910459698855;27460.588091178648;27888;28118.43763124726;28313.57529637057;28533.28666783347;900.0819164452353;913.6025828764509;944.560779237644;946.2997381937316;957.899420560845;15853.920730396274;16960.321587136623;17299.221535030953;17479.82520174782;17683.115844207994;381093;386203;386315;386588;386728;51167.744161278955;52057.21914171291;52183;52204;52215.47784522182;1078.4823284823485;1086.136521465421;1088.5264909764278;1176.253079294637;1205.3430880170329;20170.89914550418;28609.570856437585;29746.702532974392;29781.553276700433;30015;42265.366019510344;43190.352144717224;43219.35170972375;43230.783846080565;43279.13441731211;305561;307463;308162;308374;308513;38183.80908095553;38463.615363846;39431.60568394279;39539.40690889696;42651.36022959596;29035.496627561337;46289.53710462852;47275.05449890914;47502.76248618735;47604;34694.30611387808;35884.84690918553;36831.63168368389;37110.25779484449;38942.80528597339;37231.06922326964;37249.441258380604;37518.624813751514;37708.43437348497;37875.242495150495;35580;36321.27357452889;37406.62593374032;37517.81241093777;37523.2495350086;31511;33470;33803.66196338005;34545.30909381848;34679.65320346764;25441.10956116527;25527.361815954006;25646.487070258117;25891.741082588935;25980.090696825522 11:26:29 INFO - PROCESS | 24568 | |2;jquery.html;343.9972480220158;360.81237756366704;367.9392900171472;373.611444098138;393.64965180988924;12416.627501174957;16511.917440412795;16600.418985335502;16956.915215423905;18061.63876722465;13629.591112266624;13632.318384080781;14544.636384090376;15616.84383156168;15703.371865125382;5067.189249720045;5263.078961181797;5268;6459.870802583945;6713.530052896299;4084.97957510212;6861.348171923684;6899.6550172491425;6904.551204171713;6907.620080895549;5579.246801681782;6792.93207067928;6825.180978282613;6930.029795828563;6934.445244380463;6809.829754256134;6843.486738494583;6903.378695917391;6913.965430172842;6924;6433.420992110732;6589.077529145923;6590.80227593173;6592.077109204715;6593.340665933416;23264.65103023456;23293.767062329498;23634.527309453886;23661;23790.881045594833;1952.3557226115347;1980.2969945669367;2034.7660019097698;2038.1134206620168;2051.0975170924894;14103;14271.14373137615;14447.566573002827;14448.71102577953;14770.926145369205;1687.8059023212365;1689.1047744695331;1744.058208567372;1785.526835388623;1803.6933721267285;57620.71189644067;74345.25654743491;75903;77763.22236777616;80650.5967470159;15275.312610932535;16464.42374516886;16602;16933.15334233308;17609.55976100582;28669.846316905125;28727.13818585446;28736;28766.712332876403;28857.56713649297;8304.256106217641;8346.70786522481;8447.577621118919;8729.91270087291;8770.3422243332;6813.7955861324235;6955.547889387275;7060.823479413056;7062.329078737512;7095.964520177469;7970.880436793453;8296.917030829614;8443.551370102725;8499.575021248913;8568.742937711879;2749.3264150282907;3235.7249633781394;3295.8846440374473;3346.0631023313513;3356.7482438817187;739.3567596191348;824.2993455562844;859.7248880358351;874.361715947362;913.488446469979;16330.101844398434;16358;16618.58453538671;17284.22221000058;17480.65038699244;839.5634270179595;839.6053854688287;847.174005344784;893.9987214320004;898.3217670658742;7379.409647228316;9118.616843501977;9572.808543829084;9616.75958101053;9680.46757428334;281481;285840;371565;373717;374296;74847;74890;76613;81101.53941533154;81287;889.4529864133511;936.9859452108224;942.4392486470539;945.6501094595044;988.980220395588;15872.127033012834;16023.839761602701;16303.510894673178;16507.504774856774;16686.332546698482;35451.82274088716;36047.45928811018;37591.24817503689;39278.2144357117;39648.603513965645;47441.52558474371;50858;51689.48310516997;51711.48288517217;52833.20750188827;7446.739364122446;10047.698569042941;10268.435236062089;10306.793864122526;11244;11058.502367393647;11870.287782733063;11916.404179790803;12647.494100235888;13339.86660133425;7372.741954031583;7565.962170189334;8286.58567071632;10301.484925753532;10693.57225710994;10537.209709271989;10632.521536531029;10865.511052002521;10949.178811589003;11227.831582526433;10665.200109991627;10818.242723009314;10911.727206819576;11310.547578096784;11358.148138889452;10527.631532896312;10739.731506712395;10799.190060745632;10884.7278818027;11328.263662862217;10892.727681808019;10928.94535527349;10946.671599852018;11257.887421126012;11299.887001130212 11:26:29 INFO - PROCESS | 24568 | |3;mootools.html;1320.9075364724467;1357.2128165663912;1392.811970383998;1608;1625.6992456395576;7265.782026539206;7784.766457006292;7805;7810.179931107237;7811.609419529029;6504.577202481835;7203.711851525945;7400.962995185017;7427.591482468462;7677.347425468828;2158.5574957133827;2183.235867446389;2183.6942828004094;2183.8471307008517;2197.824174066071;2142.7750086240953;2171.7936796004356;2205.195103787122;2210.7457642371173;2213.7454192767796;2169.240765731997;2172.4460262633083;2175.347395781267;2177.9782202177935;2215.645496720525;2132.7547332056856;2139.6148693235214;2140.283005193262;2142.4429648291402;2146.9785302146934;2124.6919196716544;2157.8813165275906;2167.100653228908;2180.6728990651527;2181.040342249405;7700.498402811454;7735.651895664709;7739.380849532024;7854;7854.960725196337;4210.494740631144;4308.289132293168;4310.913781724379;4312.805923733439;4314.158739045887;2881.6686081100524;2931.3990631920406;3018.607581014476;3020.7281344679086;3027.1523973287512;913.7121806630956;966.120830044656;977.184051317151;980.01998001998;990.8067926754286;10280.074793268566;10296.330738501973;10312.535935882828;10314.22643301763;10319;3927.783971881574;4095.5904409559403;4203.873883783492;4212.431321771583;4217.957820421757;8765.167309105625;8870.379073464796;8872.201501864864;8874.51190184546;8887.822243555092;4348.456442944632;4357.8256869724855;4358.411614432074;4359.302511598129;4365.9126817463475;3523.361636838882;3836.0985168485386;3932.2135572885536;3952.822123004472;3966.861159859449;3589.6667166342086;3682.521272234646;3737.831797569116;3746.831392587286;3850.3646898261472;1192.3859212505567;1223.5717498875322;1230.2311055590255;1230.7169351049308;1242.0498318786135;825.2325337436242;843.5318398289008;847.3433089355675;868.9435186712843;874.4971641306274;5078.669886457443;5106.463821298785;5168.793248270103;5177.8187763428095;5264.9736751315995;405.8072415602565;408.19178027505706;416.9950419489017;417.6533477213905;420.7959139817186;3480.9825950870086;3494.545709057806;3499.9475007874903;3552.9644703552635;3657.3599620066384;9029.41308814925;9284.071592840663;9313.068693130768;9316.254699624014;9357.906420935704;9227.953860230657;9229.169374756304;9233.307501937381;9233.445993240428;9274.90725092754;6993.615351155735;7025.648717564101;7063.89404158938;7064.682089305994;7071.8939215911805;4925.1381008324115;5011.32347133147;5049.116404629249;5071.54356107952;5274.868128296824;8310.21052999964;8332.583370831555;8480.660773569234;8496.06543280251;8656.48061116335;8557.828843422973;8711.736798164104;8774.473531588124;8789.560521974003;8792.29661627081;6478.28738838718;6480.6435646038035;6541.901871472027;6677.6661166940485;6727.125473688389;7437.665305061393;7524.924750752642;7528.924710752823;7529.510581812165;7530.8493830122;6534.640594767334;6598.241202261609;6600;6607.339266073354;6702.631355275506;6200.441960223601;6247.7192175604805;6363.840903977438;6416.294207637063;6516.674166291572;6113.877722445437;6215.875682486416;6222.81331560054;6231.1276421300145;6234.906476402767;4541.364209010807;4641.257398816173;4655.6973796703105;4670.229412146958;4702.059588082328;4624.421947256593;4667.509911459248;4688.695234809727;4775.6657034007285;4887.193613053949 11:26:29 INFO - PROCESS | 24568 | |4;prototype.html;271.9986400067999;284.54756936471006;284.8380789805377;287.07847808534603;289.7421295047408;4606.5163157868365;4720.221163508017;4779.091972525222;4790.520947905212;4818.686785358949;4585.403897493329;4686.484486706459;4692.671512994092;4694.647901407391;4761.928571071437;3736.701063914894;3743.3449146399407;3746.831392587333;3750.456183853353;3752.155764952891;3554.9697178492534;3756.3989761638145;3756.849726010956;3758.7180961427866;3771.2457508498273;3321.485169798685;3589.174489867332;3732.328180927432;3755.117547376364;3767.8116094195316;3709.6290370962956;3719.6423305493436;3723.2925744108534;3730.850765969358;3744.3821769408014;3298.670132986706;3302.702756751904;3304.058343372127;3309.8179600121985;3323.7341012718925;4438.7114837535455;4596.632734141919;4653.395058642389;4653.674242803005;4665.183592871268;4242.4272723182285;4261.573842615745;4266.786660666985;4290.841472802357;4332.28517294646;4982.651214414992;5004.9749751251375;5005.124103281911;5031.22016087507;5041.369828771403;3405.540252065964;3526.7531272810916;3532.6820586147114;3541.097020259843;3569.1077230692326;5195.7402129893735;5210.7854161981;5218.086834803932;5218.817341393033;5299.708516031656;3653.0867283179205;3654.798986055739;3660.04838741929;3660.176460296412;3666.944995825065;3485.588336723631;3641.10792855752;3700.4264339027495;3703.925861500135;3715.461258117612;4170.77060761655;4217.936730949038;4222.9577704222565;4223.028703398174;4241.1941731071;4989.60083193351;4991.376077990251;5009.348784657971;5017.37282839645;5039.370078740158;1203.9458224379923;1242.8632850386632;1248.36333469931;1259.3325537465157;1277.7316763479773;825.8678611422264;840.7976593471394;858.9613467393982;862.7498025572639;864.1099667342647;4362.411074504901;4376.277914144131;4380.364847097153;4383.49589797171;4385.473743150778;5090.287359769635;5111.795528178905;5119.411267704261;5132.923006154836;5180.585553155738;4187.330027195634;4353.934690979638;4364.236258654786;4366.912661746811;4397.868063958086;2681.839089654627;2704.3915119098438;2749.6150538924567;2754;2768.2387343480705;4824.372831531879;4848.8302909398;4862.149123903303;4876.609871210295;4888.462269150391;5010.423801262901;5286.286351342519;5314.70769107695;5321.068812957717;5372.946270537323;4924.162892308316;4926.605871530341;4927.679700819435;4962.528559786814;4995.300657907823;4935.309056731989;5191.676122588867;5198.9740051299505;5267.367915850123;5268.446813084724;5048.59611231108;5124.56441202502;5152;5158.819441319536;5167.948320516747;4954.653174277766;4973.577245934136;4977.054359671651;4981.8007279709855;4986.8753281168265;3531.3820081485123;3626.836792344298;3630.546181727284;3640.290143422007;3669.7155995401395;5100.974495127501;5110.540051395392;5118.769655365443;5125.384953805567;5167.58659307247;5036.118679231193;5084;5093.821716239914;5124.871878203075;5127.282180494659;4964.627652926118;4998.275594919747;5061.240813877947;5106.719130447861;5120.462351453044;4751.311059896227;4812.326274321527;4943.110240156806;4951;4977.456988333483;5122.795088196431;5127.435982042047;5131.666441681428;5136.383633963799;5148;5020.648554601143;5021.49785021495;5032.672876263031;5034.798608055637;5036.179739345978 11:26:29 INFO - PROCESS | 24568 | |5;yui.html;629.4555209743573;634.9079383489393;652.4649787174512;672.0926748888998;725.0936329588015;11447.828282575758;12117.818232726506;12123.515059397625;12321.753564928697;12344.197627154228;12078;12279.570215042475;12330.630081097559;12347.444365003574;12356;622.2626187967273;745.2547452547466;745.4781652843004;769.0002996105069;775.1434664695515;745.3701622129292;756.6935391166586;761.8742907420269;762.3405754022758;762.4396068889362;809.3686924199134;810.5866008335732;810.9351251899864;811.5495899775622;811.6753298680545;652.1847690387016;667.7896462614261;806.6249194124731;807.2855522862279;807.7132617920612;487.7853744352509;491.14785846556197;578.806099956515;585.4350551717571;589.1516216648013;13476.86523134766;13516.459341626323;13519.256440895746;13531.39108740109;13531.729365412735;12436.067294952823;12761.234325940473;12802.167859089222;13429.66425839352;13654.112482688593;11740.882591174064;11859.703507412298;12054.638360849189;12292.692682682915;12452.377381130907;4030.0932290234755;4079.2453396121514;4267.829286828523;4276.123394704078;4277.101808620194;64547.67726161386;64963.02555461672;65034;65353.99999999953;65546.3445365545;9908.801823963624;10096.596136154472;10411.219158563137;10434.373937563618;10487.265891387682;16775.664486710197;18143.818561814212;18228.726569101473;18238.08809559517;18270;6998.965005174941;7007.668542976818;7061.611611361424;7077.292270772985;7202.92797072033;3726.4969229153717;3746.6440688134585;3767.1900541383734;3788.242351529705;3837.021559502309;2939.6472423309338;3070.5087186050123;3079.7536197104178;3087.9536806947913;3091.211741006074;516.8733660253187;516.9043726910534;517.7592419524939;526.3263023330144;541.0747621567165;505.5172310443518;524.4860037163601;530.2110896683473;538.8410418926426;639.9520035997319;7919.643616037292;8438.831223375499;8613.021025084781;8645.351598630128;8793.384463087523;575.6804973239808;597.6115524908844;612.295859761278;619.5013014523352;630.760311081786;3820.178661587772;4220.746755194698;4235.618794308527;4289.270823959934;4366.759828209479;55697;55878.720606397525;55926.440735592936;56000.719996399755;57328.713356433786;50406.49593504091;51009;74249.62875185697;86315.56842215749;87517.56241218753;43632.78183609062;45459.77270113694;70862.9370559442;74406.62796685981;74682;8239.876401854097;8516.361272904433;8576.099509551408;8756.124387561193;9042.50266235337;43965.560344396145;44064.77967610142;44569.70466814893;45073;46391.53608463872;62021;62688.68655656875;64098.679506602166;66086.33913660802;66316.33683663102;11470.82793758111;11567.363794991355;11602.361870097226;11653.76692466129;11727.88272117302;13102.541411050568;13373.598792036255;13401;13634;13639.318034098455;10765.838512422477;10780.083692885879;10865.619703310345;10913.508892099715;11328.603498877499;11186.32882027081;11348.886511134782;11510.59712910044;12042.397880105784;12189.57336493254;11414.201005929837;11508.424578771195;11967.166826010915;12094;12095.637130886087;9015.188633022797;9075.2286055686;9128.132827381389;9183.632654693738;9749.122578967927;9065.954670226607;10220.9475461934;10314.41392425927;10516.894831051592;10533.473326333806 11:26:29 INFO - PROCESS | 24568 | __end_tp_report 11:26:29 INFO - PROCESS | 24568 | __start_cc_report 11:26:29 INFO - PROCESS | 24568 | _x_x_mozilla_cycle_collect,1046 11:26:29 INFO - PROCESS | 24568 | __end_cc_report 11:26:29 INFO - PROCESS | 24568 | __startTimestamp1471631189283__endTimestamp 11:26:29 INFO - PROCESS | 24568 | 11:26:29 INFO - PROCESS | 24568 | ------- Summary: start ------- 11:26:29 INFO - PROCESS | 24568 | Number of tests: 6 11:26:29 INFO - PROCESS | 24568 | 11:26:29 INFO - PROCESS | 24568 | [#0] dojo.html Cycles:165 Average:4625.56 Median:4776.21 stddev:490.83 (10.3%) stddev-sans-first:464.64 11:26:29 INFO - PROCESS | 24568 | Values: 2553.3 2580.5 2589.2 2599.4 2602.2 4574.2 4609.9 4619.8 4697.8 4698.7 4590.9 4616.0 4671.0 4679.2 4695.3 4218.9 4246.9 4321.6 4360.7 4364.5 4346.7 4370.4 4386.3 4388.9 4391.5 4193.4 4239.0 4250.6 4306.1 4315.5 4178.5 4207.2 4209.2 4219.2 4285.2 4234.3 4235.3 4256.9 4261.1 4291.1 4702.0 4704.1 4705.8 4712.6 4716.9 4865.5 4895.5 4938.1 4955.2 5018.3 4976.6 5011.1 5014.5 5019.8 5023.3 4522.9 4711.2 4713.6 4714.6 4718.2 5049.9 5100.9 5116.2 5169.1 5185.3 4965.3 4975.5 4976.3 4981.4 4997.0 4818.0 5031.1 5037.4 5042.2 5043.3 4911.8 4964.1 4965.9 5014.8 5042.6 4994.4 5006.2 5010.9 5010.9 5013.5 4073.6 4257.6 4259.4 4259.7 4272.0 3669.3 3725.3 3730.2 3739.4 3796.3 4323.5 4344.2 4350.2 4355.2 4359.5 4824.1 5040.9 5081.9 5098.1 5100.0 4246.6 4287.3 4295.1 4343.9 4349.0 4532.2 4546.3 4549.4 4549.7 4557.3 4603.0 4776.2 4791.2 4800.6 4801.3 4983.5 4995.8 5019.2 5071.9 5096.6 4763.9 4798.0 4799.4 4799.9 4806.5 4782.2 4913.9 4945.1 4958.3 4961.0 4932.2 4976.4 5001.6 5036.8 5064.3 4910.8 4921.7 4923.4 4927.1 4928.5 4717.2 4930.2 4943.6 4956.4 4957.1 4712.8 4741.8 4761.1 4785.8 4805.5 4874.1 4892.3 4896.5 4901.8 4903.8 4669.9 4806.5 4807.7 4811.8 4814.0 11:26:29 INFO - PROCESS | 24568 | 11:26:29 INFO - PROCESS | 24568 | [#1] ext.html Cycles:180 Average:46709.39 Median:36970.94 stddev:83737.91 (226.5%) stddev-sans-first:83901.16 11:26:29 INFO - PROCESS | 24568 | Values: 567.6 567.9 574.2 575.7 576.8 39856.0 41036.6 41128.2 44666.3 44693.0 40433.6 41009.2 41024.6 41110.4 41112.2 7425.0 7634.0 7776.3 7777.0 9836.3 9723.1 10088.1 10103.4 10106.3 10127.6 10161.7 10181.7 10203.5 10216.8 10218.2 10174.8 10179.6 10215.0 10216.5 10218.2 9842.8 9906.5 9912.4 9914.0 9918.6 38940.8 39208.6 39225.6 39295.8 39311.4 3019.9 3066.4 3101.1 3162.0 3257.4 28651.9 28956.0 29116.4 29117.0 30749.5 3273.3 3316.9 3339.7 3364.4 3374.5 245392.0 245778.0 245865.0 246424.0 247416.0 29205.9 51994.0 52234.0 52322.0 52328.5 30680.5 30884.4 30959.8 31078.0 31113.4 12016.7 12226.0 12226.3 12227.4 12249.2 9135.0 9241.0 9245.3 9456.7 9538.1 7532.2 7716.4 7816.8 7905.2 7909.7 2996.3 3016.9 3027.9 3107.6 3126.9 793.8 825.7 875.8 901.9 949.8 27460.6 27888.0 28118.4 28313.6 28533.3 900.1 913.6 944.6 946.3 957.9 15853.9 16960.3 17299.2 17479.8 17683.1 381093.0 386203.0 386315.0 386588.0 386728.0 51167.7 52057.2 52183.0 52204.0 52215.5 1078.5 1086.1 1088.5 1176.3 1205.3 20170.9 28609.6 29746.7 29781.6 30015.0 42265.4 43190.4 43219.4 43230.8 43279.1 305561.0 307463.0 308162.0 308374.0 308513.0 38183.8 38463.6 39431.6 39539.4 42651.4 29035.5 46289.5 47275.1 47502.8 47604.0 34694.3 35884.8 36831.6 37110.3 38942.8 37231.1 37249.4 37518.6 37708.4 37875.2 35580.0 36321.3 37406.6 37517.8 37523.2 31511.0 33470.0 33803.7 34545.3 34679.7 25441.1 25527.4 25646.5 25891.7 25980.1 11:26:29 INFO - PROCESS | 24568 | 11:26:29 INFO - PROCESS | 24568 | [#2] jquery.html Cycles:180 Average:24269.06 Median:18204.14 stddev:56490.72 (310.3%) stddev-sans-first:56620.63 11:26:29 INFO - PROCESS | 24568 | Values: 344.0 360.8 367.9 373.6 393.6 12416.6 16511.9 16600.4 16956.9 18061.6 13629.6 13632.3 14544.6 15616.8 15703.4 5067.2 5263.1 5268.0 6459.9 6713.5 4085.0 6861.3 6899.7 6904.6 6907.6 5579.2 6792.9 6825.2 6930.0 6934.4 6809.8 6843.5 6903.4 6914.0 6924.0 6433.4 6589.1 6590.8 6592.1 6593.3 23264.7 23293.8 23634.5 23661.0 23790.9 1952.4 1980.3 2034.8 2038.1 2051.1 14103.0 14271.1 14447.6 14448.7 14770.9 1687.8 1689.1 1744.1 1785.5 1803.7 57620.7 74345.3 75903.0 77763.2 80650.6 15275.3 16464.4 16602.0 16933.2 17609.6 28669.8 28727.1 28736.0 28766.7 28857.6 8304.3 8346.7 8447.6 8729.9 8770.3 6813.8 6955.5 7060.8 7062.3 7096.0 7970.9 8296.9 8443.6 8499.6 8568.7 2749.3 3235.7 3295.9 3346.1 3356.7 739.4 824.3 859.7 874.4 913.5 16330.1 16358.0 16618.6 17284.2 17480.7 839.6 839.6 847.2 894.0 898.3 7379.4 9118.6 9572.8 9616.8 9680.5 281481.0 285840.0 371565.0 373717.0 374296.0 74847.0 74890.0 76613.0 81101.5 81287.0 889.5 937.0 942.4 945.7 989.0 15872.1 16023.8 16303.5 16507.5 16686.3 35451.8 36047.5 37591.2 39278.2 39648.6 47441.5 50858.0 51689.5 51711.5 52833.2 7446.7 10047.7 10268.4 10306.8 11244.0 11058.5 11870.3 11916.4 12647.5 13339.9 7372.7 7566.0 8286.6 10301.5 10693.6 10537.2 10632.5 10865.5 10949.2 11227.8 10665.2 10818.2 10911.7 11310.5 11358.1 10527.6 10739.7 10799.2 10884.7 11328.3 10892.7 10928.9 10946.7 11257.9 11299.9 11:26:29 INFO - PROCESS | 24568 | 11:26:29 INFO - PROCESS | 24568 | [#3] mootools.html Cycles:180 Average:5002.11 Median:4968.23 stddev:2779.56 (55.9%) stddev-sans-first:2773.59 11:26:29 INFO - PROCESS | 24568 | Values: 1320.9 1357.2 1392.8 1608.0 1625.7 7265.8 7784.8 7805.0 7810.2 7811.6 6504.6 7203.7 7401.0 7427.6 7677.3 2158.6 2183.2 2183.7 2183.8 2197.8 2142.8 2171.8 2205.2 2210.7 2213.7 2169.2 2172.4 2175.3 2178.0 2215.6 2132.8 2139.6 2140.3 2142.4 2147.0 2124.7 2157.9 2167.1 2180.7 2181.0 7700.5 7735.7 7739.4 7854.0 7855.0 4210.5 4308.3 4310.9 4312.8 4314.2 2881.7 2931.4 3018.6 3020.7 3027.2 913.7 966.1 977.2 980.0 990.8 10280.1 10296.3 10312.5 10314.2 10319.0 3927.8 4095.6 4203.9 4212.4 4218.0 8765.2 8870.4 8872.2 8874.5 8887.8 4348.5 4357.8 4358.4 4359.3 4365.9 3523.4 3836.1 3932.2 3952.8 3966.9 3589.7 3682.5 3737.8 3746.8 3850.4 1192.4 1223.6 1230.2 1230.7 1242.0 825.2 843.5 847.3 868.9 874.5 5078.7 5106.5 5168.8 5177.8 5265.0 405.8 408.2 417.0 417.7 420.8 3481.0 3494.5 3499.9 3553.0 3657.4 9029.4 9284.1 9313.1 9316.3 9357.9 9228.0 9229.2 9233.3 9233.4 9274.9 6993.6 7025.6 7063.9 7064.7 7071.9 4925.1 5011.3 5049.1 5071.5 5274.9 8310.2 8332.6 8480.7 8496.1 8656.5 8557.8 8711.7 8774.5 8789.6 8792.3 6478.3 6480.6 6541.9 6677.7 6727.1 7437.7 7524.9 7528.9 7529.5 7530.8 6534.6 6598.2 6600.0 6607.3 6702.6 6200.4 6247.7 6363.8 6416.3 6516.7 6113.9 6215.9 6222.8 6231.1 6234.9 4541.4 4641.3 4655.7 4670.2 4702.1 4624.4 4667.5 4688.7 4775.7 4887.2 11:26:29 INFO - PROCESS | 24568 | 11:26:29 INFO - PROCESS | 24568 | [#4] prototype.html Cycles:180 Average:4165.65 Median:4735.77 stddev:1223.81 (25.8%) stddev-sans-first:1191.83 11:26:29 INFO - PROCESS | 24568 | Values: 272.0 284.5 284.8 287.1 289.7 4606.5 4720.2 4779.1 4790.5 4818.7 4585.4 4686.5 4692.7 4694.6 4761.9 3736.7 3743.3 3746.8 3750.5 3752.2 3555.0 3756.4 3756.8 3758.7 3771.2 3321.5 3589.2 3732.3 3755.1 3767.8 3709.6 3719.6 3723.3 3730.9 3744.4 3298.7 3302.7 3304.1 3309.8 3323.7 4438.7 4596.6 4653.4 4653.7 4665.2 4242.4 4261.6 4266.8 4290.8 4332.3 4982.7 5005.0 5005.1 5031.2 5041.4 3405.5 3526.8 3532.7 3541.1 3569.1 5195.7 5210.8 5218.1 5218.8 5299.7 3653.1 3654.8 3660.0 3660.2 3666.9 3485.6 3641.1 3700.4 3703.9 3715.5 4170.8 4217.9 4223.0 4223.0 4241.2 4989.6 4991.4 5009.3 5017.4 5039.4 1203.9 1242.9 1248.4 1259.3 1277.7 825.9 840.8 859.0 862.7 864.1 4362.4 4376.3 4380.4 4383.5 4385.5 5090.3 5111.8 5119.4 5132.9 5180.6 4187.3 4353.9 4364.2 4366.9 4397.9 2681.8 2704.4 2749.6 2754.0 2768.2 4824.4 4848.8 4862.1 4876.6 4888.5 5010.4 5286.3 5314.7 5321.1 5372.9 4924.2 4926.6 4927.7 4962.5 4995.3 4935.3 5191.7 5199.0 5267.4 5268.4 5048.6 5124.6 5152.0 5158.8 5167.9 4954.7 4973.6 4977.1 4981.8 4986.9 3531.4 3626.8 3630.5 3640.3 3669.7 5101.0 5110.5 5118.8 5125.4 5167.6 5036.1 5084.0 5093.8 5124.9 5127.3 4964.6 4998.3 5061.2 5106.7 5120.5 4751.3 4812.3 4943.1 4951.0 4977.5 5122.8 5127.4 5131.7 5136.4 5148.0 5020.6 5021.5 5032.7 5034.8 5036.2 11:26:29 INFO - PROCESS | 24568 | 11:26:29 INFO - PROCESS | 24568 | [#5] yui.html Cycles:180 Average:16035.84 Median:489.47 stddev:21026.43 (4295.8%) stddev-sans-first:21053.59 11:26:29 INFO - PROCESS | 24568 | Values: 629.5 634.9 652.5 672.1 725.1 11447.8 12117.8 12123.5 12321.8 12344.2 12078.0 12279.6 12330.6 12347.4 12356.0 622.3 745.3 745.5 769.0 775.1 745.4 756.7 761.9 762.3 762.4 809.4 810.6 810.9 811.5 811.7 652.2 667.8 806.6 807.3 807.7 487.8 491.1 578.8 585.4 589.2 13476.9 13516.5 13519.3 13531.4 13531.7 12436.1 12761.2 12802.2 13429.7 13654.1 11740.9 11859.7 12054.6 12292.7 12452.4 4030.1 4079.2 4267.8 4276.1 4277.1 64547.7 64963.0 65034.0 65354.0 65546.3 9908.8 10096.6 10411.2 10434.4 10487.3 16775.7 18143.8 18228.7 18238.1 18270.0 6999.0 7007.7 7061.6 7077.3 7202.9 3726.5 3746.6 3767.2 3788.2 3837.0 2939.6 3070.5 3079.8 3088.0 3091.2 516.9 516.9 517.8 526.3 541.1 505.5 524.5 530.2 538.8 640.0 7919.6 8438.8 8613.0 8645.4 8793.4 575.7 597.6 612.3 619.5 630.8 3820.2 4220.7 4235.6 4289.3 4366.8 55697.0 55878.7 55926.4 56000.7 57328.7 50406.5 51009.0 74249.6 86315.6 87517.6 43632.8 45459.8 70862.9 74406.6 74682.0 8239.9 8516.4 8576.1 8756.1 9042.5 43965.6 44064.8 44569.7 45073.0 46391.5 62021.0 62688.7 64098.7 66086.3 66316.3 11470.8 11567.4 11602.4 11653.8 11727.9 13102.5 13373.6 13401.0 13634.0 13639.3 10765.8 10780.1 10865.6 10913.5 11328.6 11186.3 11348.9 11510.6 12042.4 12189.6 11414.2 11508.4 11967.2 12094.0 12095.6 9015.2 9075.2 9128.1 9183.6 9749.1 9066.0 10220.9 10314.4 10516.9 10533.5 11:26:29 INFO - PROCESS | 24568 | -------- Summary: end -------- 11:26:29 INFO - PROCESS | 24568 | 11:26:30 INFO - TEST-INFO | 24568: exit 0 11:26:30 INFO - TEST-OK | dromaeo_css | took 1119164ms 11:26:30 INFO - TEST-START | kraken 11:26:30 INFO - operating with platform_type : linux_ 11:26:30 INFO - Initialising browser for kraken test... 11:26:30 INFO - TEST-INFO | started process 24872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjDYOFs/profile http://localhost:40614/getInfo.html) 11:26:34 INFO - PROCESS | 24872 | __metrics Screen width/height:1600/1200 11:26:34 INFO - PROCESS | 24872 | colorDepth:24 11:26:34 INFO - PROCESS | 24872 | Browser inner width/height: 1024/697 11:26:34 INFO - PROCESS | 24872 | __metrics 11:26:34 INFO - PROCESS | 24872 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:26:34 INFO - PROCESS | 24872 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:26:35 INFO - PROCESS | 24872 | console.error: PushService: 11:26:35 INFO - PROCESS | 24872 | stateChangeProcessEnqueue: Error transitioning state 11:26:35 INFO - PROCESS | 24872 | UnknownError 11:26:35 INFO - TEST-INFO | 24872: exit 0 11:26:35 INFO - Browser initialized. 11:26:35 INFO - Running cycle 1/1 for kraken test... 11:26:35 INFO - TEST-INFO | started process 24953 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjDYOFs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:47 INFO - PROCESS | 24953 | RSS: Main: 157167616 11:26:47 INFO - PROCESS | 24953 | 11:26:50 INFO - PROCESS | 24953 | Cycle 1(1): loaded http://localhost:40614/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40614/tests/kraken/driver.html?testName=audio-beat-detection) 11:26:51 INFO - PROCESS | 24953 | RSS: Main: 212152320 11:26:51 INFO - PROCESS | 24953 | 11:26:53 INFO - PROCESS | 24953 | Cycle 1(1): loaded http://localhost:40614/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40614/tests/kraken/driver.html?testName=audio-dft) 11:26:54 INFO - PROCESS | 24953 | RSS: Main: 190697472 11:26:54 INFO - PROCESS | 24953 | 11:26:57 INFO - PROCESS | 24953 | Cycle 1(1): loaded http://localhost:40614/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40614/tests/kraken/driver.html?testName=audio-fft) 11:26:58 INFO - PROCESS | 24953 | RSS: Main: 269484032 11:26:58 INFO - PROCESS | 24953 | 11:27:00 INFO - PROCESS | 24953 | Cycle 1(1): loaded http://localhost:40614/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40614/tests/kraken/driver.html?testName=audio-oscillator) 11:27:01 INFO - PROCESS | 24953 | RSS: Main: 179568640 11:27:01 INFO - PROCESS | 24953 | 11:27:03 INFO - PROCESS | 24953 | Cycle 1(1): loaded http://localhost:40614/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40614/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:27:04 INFO - PROCESS | 24953 | RSS: Main: 183910400 11:27:04 INFO - PROCESS | 24953 | 11:27:07 INFO - PROCESS | 24953 | Cycle 1(1): loaded http://localhost:40614/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40614/tests/kraken/driver.html?testName=imaging-darkroom) 11:27:07 INFO - PROCESS | 24953 | RSS: Main: 220979200 11:27:07 INFO - PROCESS | 24953 | 11:27:11 INFO - PROCESS | 24953 | Cycle 1(1): loaded http://localhost:40614/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40614/tests/kraken/driver.html?testName=imaging-desaturate) 11:27:11 INFO - PROCESS | 24953 | RSS: Main: 219201536 11:27:11 INFO - PROCESS | 24953 | 11:27:14 INFO - PROCESS | 24953 | Cycle 1(1): loaded http://localhost:40614/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40614/tests/kraken/driver.html?testName=json-parse-financial) 11:27:15 INFO - PROCESS | 24953 | RSS: Main: 219168768 11:27:15 INFO - PROCESS | 24953 | 11:27:17 INFO - PROCESS | 24953 | Cycle 1(1): loaded http://localhost:40614/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40614/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:27:17 INFO - PROCESS | 24953 | RSS: Main: 182489088 11:27:17 INFO - PROCESS | 24953 | 11:27:19 INFO - PROCESS | 24953 | Cycle 1(1): loaded http://localhost:40614/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40614/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:27:20 INFO - PROCESS | 24953 | RSS: Main: 189022208 11:27:20 INFO - PROCESS | 24953 | 11:27:22 INFO - PROCESS | 24953 | Cycle 1(1): loaded http://localhost:40614/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40614/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:27:23 INFO - PROCESS | 24953 | RSS: Main: 194134016 11:27:23 INFO - PROCESS | 24953 | 11:27:26 INFO - PROCESS | 24953 | Cycle 1(1): loaded http://localhost:40614/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40614/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:27:26 INFO - PROCESS | 24953 | RSS: Main: 188776448 11:27:26 INFO - PROCESS | 24953 | 11:27:29 INFO - PROCESS | 24953 | Cycle 1(1): loaded http://localhost:40614/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40614/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:27:30 INFO - PROCESS | 24953 | RSS: Main: 193069056 11:27:30 INFO - PROCESS | 24953 | 11:27:31 INFO - PROCESS | 24953 | Cycle 1(1): loaded http://localhost:40614/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40614/tests/kraken/driver.html?testName=ai-astar) 11:27:32 INFO - PROCESS | 24953 | RSS: Main: 243093504 11:27:32 INFO - PROCESS | 24953 | 11:27:32 INFO - PROCESS | 24953 | __start_tp_report 11:27:32 INFO - PROCESS | 24953 | _x_x_mozilla_page_load 11:27:32 INFO - PROCESS | 24953 | _x_x_mozilla_page_load_details 11:27:32 INFO - PROCESS | 24953 | |i|pagename|runs| 11:27:32 INFO - PROCESS | 24953 | |0;ai-astar;106;116;115;115;114;114;113;114;113;114 11:27:32 INFO - PROCESS | 24953 | |1;audio-beat-detection;152;124;130;185;124;128;148;123;164;123 11:27:32 INFO - PROCESS | 24953 | |2;audio-dft;161;163;161;163;162;162;161;162;160;162 11:27:32 INFO - PROCESS | 24953 | |3;audio-fft;76;77;76;103;76;77;75;75;110;79 11:27:32 INFO - PROCESS | 24953 | |4;audio-oscillator;85;86;130;86;85;85;119;87;86;131 11:27:32 INFO - PROCESS | 24953 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;116;117 11:27:32 INFO - PROCESS | 24953 | |6;imaging-darkroom;146;146;146;147;147;146;146;147;146;146 11:27:32 INFO - PROCESS | 24953 | |7;imaging-desaturate;95;95;94;95;95;94;95;95;95;94 11:27:32 INFO - PROCESS | 24953 | |8;json-parse-financial;63;62;64;64;64;64;64;65;65;64 11:27:32 INFO - PROCESS | 24953 | |9;json-stringify-tinderbox;65;66;66;66;65;66;66;67;65;65 11:27:32 INFO - PROCESS | 24953 | |10;stanford-crypto-aes;87;82;83;83;82;83;83;81;81;81 11:27:32 INFO - PROCESS | 24953 | |11;stanford-crypto-ccm;143;148;140;148;148;129;135;133;165;133 11:27:32 INFO - PROCESS | 24953 | |12;stanford-crypto-pbkdf2;171;174;170;173;174;176;176;171;170;170 11:27:32 INFO - PROCESS | 24953 | |13;stanford-crypto-sha256-iterative;68;69;68;68;69;71;68;67;66;67 11:27:32 INFO - PROCESS | 24953 | __end_tp_report 11:27:32 INFO - PROCESS | 24953 | __start_cc_report 11:27:32 INFO - PROCESS | 24953 | _x_x_mozilla_cycle_collect,1961 11:27:32 INFO - PROCESS | 24953 | __end_cc_report 11:27:32 INFO - PROCESS | 24953 | __startTimestamp1471631252218__endTimestamp 11:27:32 INFO - PROCESS | 24953 | 11:27:32 INFO - PROCESS | 24953 | ------- Summary: start ------- 11:27:32 INFO - PROCESS | 24953 | Number of tests: 14 11:27:32 INFO - PROCESS | 24953 | 11:27:32 INFO - PROCESS | 24953 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:2.76 (2.4%) stddev-sans-first:0.97 11:27:32 INFO - PROCESS | 24953 | Values: 106.0 116.0 115.0 115.0 114.0 114.0 113.0 114.0 113.0 114.0 11:27:32 INFO - PROCESS | 24953 | 11:27:32 INFO - PROCESS | 24953 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:139.00 stddev:21.46 (15.4%) stddev-sans-first:22.32 11:27:32 INFO - PROCESS | 24953 | Values: 152.0 124.0 130.0 185.0 124.0 128.0 148.0 123.0 164.0 123.0 11:27:32 INFO - PROCESS | 24953 | 11:27:32 INFO - PROCESS | 24953 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 11:27:32 INFO - PROCESS | 24953 | Values: 161.0 163.0 161.0 163.0 162.0 162.0 161.0 162.0 160.0 162.0 11:27:32 INFO - PROCESS | 24953 | 11:27:32 INFO - PROCESS | 24953 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.00 stddev:12.86 (16.9%) stddev-sans-first:13.43 11:27:32 INFO - PROCESS | 24953 | Values: 76.0 77.0 76.0 103.0 76.0 77.0 75.0 75.0 110.0 79.0 11:27:32 INFO - PROCESS | 24953 | 11:27:32 INFO - PROCESS | 24953 | [#4] audio-oscillator Cycles:10 Average:98.00 Median:85.50 stddev:20.04 (23.4%) stddev-sans-first:20.69 11:27:32 INFO - PROCESS | 24953 | Values: 85.0 86.0 130.0 86.0 85.0 85.0 119.0 87.0 86.0 131.0 11:27:32 INFO - PROCESS | 24953 | 11:27:32 INFO - PROCESS | 24953 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:27:32 INFO - PROCESS | 24953 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 11:27:32 INFO - PROCESS | 24953 | 11:27:32 INFO - PROCESS | 24953 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 11:27:32 INFO - PROCESS | 24953 | Values: 146.0 146.0 146.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 11:27:32 INFO - PROCESS | 24953 | 11:27:32 INFO - PROCESS | 24953 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:27:32 INFO - PROCESS | 24953 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 11:27:32 INFO - PROCESS | 24953 | 11:27:32 INFO - PROCESS | 24953 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.88 (1.4%) stddev-sans-first:0.87 11:27:32 INFO - PROCESS | 24953 | Values: 63.0 62.0 64.0 64.0 64.0 64.0 64.0 65.0 65.0 64.0 11:27:32 INFO - PROCESS | 24953 | 11:27:32 INFO - PROCESS | 24953 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 11:27:32 INFO - PROCESS | 24953 | Values: 65.0 66.0 66.0 66.0 65.0 66.0 66.0 67.0 65.0 65.0 11:27:32 INFO - PROCESS | 24953 | 11:27:32 INFO - PROCESS | 24953 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:1.78 (2.1%) stddev-sans-first:0.93 11:27:32 INFO - PROCESS | 24953 | Values: 87.0 82.0 83.0 83.0 82.0 83.0 83.0 81.0 81.0 81.0 11:27:32 INFO - PROCESS | 24953 | 11:27:32 INFO - PROCESS | 24953 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:145.50 stddev:10.65 (7.3%) stddev-sans-first:11.30 11:27:32 INFO - PROCESS | 24953 | Values: 143.0 148.0 140.0 148.0 148.0 129.0 135.0 133.0 165.0 133.0 11:27:32 INFO - PROCESS | 24953 | 11:27:32 INFO - PROCESS | 24953 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:173.50 stddev:2.42 (1.4%) stddev-sans-first:2.50 11:27:32 INFO - PROCESS | 24953 | Values: 171.0 174.0 170.0 173.0 174.0 176.0 176.0 171.0 170.0 170.0 11:27:32 INFO - PROCESS | 24953 | 11:27:32 INFO - PROCESS | 24953 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.37 (2.0%) stddev-sans-first:1.45 11:27:32 INFO - PROCESS | 24953 | Values: 68.0 69.0 68.0 68.0 69.0 71.0 68.0 67.0 66.0 67.0 11:27:32 INFO - PROCESS | 24953 | -------- Summary: end -------- 11:27:32 INFO - PROCESS | 24953 | 11:27:33 INFO - TEST-INFO | 24953: exit 0 11:27:33 INFO - TEST-OK | kraken | took 63240ms 11:27:33 INFO - SUITE-END | took 1182s 11:27:33 INFO - Completed test suite (00:19:42) 11:27:33 INFO - javascript benchmark 11:27:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2553.3361326055224, 2580.4839032193568, 2589.236175328278, 2599.3631560267736, 2602.1803132013415, 4574.176648203331, 4609.930851037233, 4619.7921093550785, 4697.835575754849, 4698.694584851983, 4590.862274131773, 4615.953840461594, 4670.97664511677, 4679.15775160471, 4695.2957056441555, 4218.852340168095, 4246.8725938221905, 4321.632661223784, 4360.672949528782, 4364.476262848447, 4346.6522678185665, 4370.4099946507295, 4386.32012038133, 4388.86833394997, 4391.494978077514, 4193.433886425324, 4239.0, 4250.638695710868, 4306.117245964585, 4315.4605674290715, 4178.498580170369, 4207.158568286355, 4209.179210054041, 4219.2194444027955, 4285.185814695198, 4234.30134027885, 4235.2800023996, 4256.893577660552, 4261.147770445892, 4291.120320334324, 4701.976490117561, 4704.106219818258, 4705.788239529229, 4712.622990160813, 4716.9056618867435, 4865.537773911473, 4895.510448955111, 4938.1111399947995, 4955.157623204028, 5018.2974383586325, 4976.601871850279, 5011.098002359574, 5014.52362025607, 5019.7741101650145, 5023.271625614302, 4522.932156017662, 4711.151992641289, 4713.622910167179, 4714.6464015199, 4718.245080787126, 5049.8737531562, 5100.897982040338, 5116.181410974226, 5169.121249387538, 5185.299984502044, 4965.255211718199, 4975.4527002029745, 4976.253561965734, 4981.42713587942, 4996.950030499648, 4818.0, 5031.119554078022, 5037.420696619935, 5042.168042272984, 5043.344365232496, 4911.778969946361, 4964.106460837084, 4965.851024469272, 5014.799408023711, 5042.571381432546, 4994.375703037121, 5006.173981293119, 5010.874728131753, 5010.89978200434, 5013.548780609763, 4073.6130067643526, 4257.595528424795, 4259.42497762798, 4259.659227261812, 4272.0, 3669.2661467706566, 3725.3294407006997, 3730.1607138393642, 3739.4390841373465, 3796.335641262768, 4323.524412314643, 4344.152890186447, 4350.21696094706, 4355.172517221781, 4359.498657654347, 4824.131656301829, 5040.873978150502, 5081.949180508148, 5098.133317336062, 5100.0, 4246.617804397619, 4287.335463003239, 4295.119500502389, 4343.891402714894, 4349.043210493686, 4532.1842068427995, 4546.272596384562, 4549.431321084864, 4549.681522293407, 4557.316402539579, 4603.0, 4776.2119250324, 4791.209450440639, 4800.591949684316, 4801.303810947463, 4983.501649835132, 4995.775190116381, 5019.171836646912, 5071.880793312161, 5096.592272618256, 4763.880902977315, 4798.04039192156, 4799.448063472606, 4799.928001079917, 4806.543378379049, 4782.163121453801, 4913.901721965469, 4945.085159245551, 4958.281049247911, 4961.0, 4932.161532539405, 4976.377952755905, 5001.624878134082, 5036.834843420819, 5064.34163558735, 4910.779014944407, 4921.704697718148, 4923.433805112458, 4927.1131196384995, 4928.457869634266, 4717.150912835723, 4930.211166213532, 4943.629227807857, 4956.430010548833, 4957.107720610325, 4712.787924543472, 4741.83403580873, 4761.119192949315, 4785.808567657394, 4805.549169923294, 4874.147024270667, 4892.2661600760175, 4896.461389247252, 4901.779419926183, 4903.754812259444, 4669.906601867876, 4806.519348065165, 4807.663463557517, 4811.807527698853, 4814.0], "value": 4593.719639281552, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.6026781253124, 567.920491131242, 574.1502576187243, 575.6977586766947, 576.7865889620841, 39856.0, 41036.58963410365, 41128.17743645129, 44666.33000504995, 44693.0, 40433.59566404335, 41009.17981640365, 41024.58975410245, 41110.383344249785, 41112.17775644486, 7425.03474548308, 7634.0, 7776.30013298803, 7776.961115194416, 9836.31145819793, 9723.12491875731, 10088.092071713545, 10103.393796372204, 10106.292559520836, 10127.645532406368, 10161.745956351077, 10181.745456363577, 10203.540840662188, 10216.795664086714, 10218.182545396388, 10174.796504069951, 10179.592816287377, 10215.0, 10216.489175541268, 10218.18254539635, 9842.753931151707, 9906.504674766305, 9912.405255684609, 9914.0, 9918.603255869757, 38940.80529597334, 39208.60791392078, 39225.60774392248, 39295.803520982496, 39311.41032884509, 3019.9094027179, 3066.371393864275, 3101.116181888151, 3162.0197738701077, 3257.4136655402017, 28651.856740716372, 28956.0, 29116.41767164645, 29117.0, 30749.538756918664, 3273.312604353089, 3316.9170770730684, 3339.699427051577, 3364.3775901458066, 3374.5106959490736, 245391.99999999822, 245778.0, 245865.0, 246424.0, 247416.0, 29205.85397073001, 51994.0, 52234.0, 52322.0, 52328.47671523312, 30680.53979190314, 30884.382312354075, 30959.845200773852, 31078.0, 31113.37773244568, 12016.699582510508, 12226.0, 12226.266424014588, 12227.388630568435, 12249.203801752858, 9135.040820713863, 9241.0, 9245.306602004877, 9456.716298511055, 9538.093881081286, 7532.209118042636, 7716.382689384835, 7816.765497035098, 7905.169957154531, 7909.683612655429, 2996.3258266889775, 3016.8642411091555, 3027.8940237091597, 3107.6115485564305, 3126.906192814219, 793.8491686579531, 825.7027470110755, 875.772299202212, 901.8782464367358, 949.7910459698855, 27460.588091178648, 27888.0, 28118.43763124726, 28313.57529637057, 28533.28666783347, 900.0819164452353, 913.6025828764509, 944.560779237644, 946.2997381937316, 957.899420560845, 15853.920730396274, 16960.321587136623, 17299.221535030953, 17479.82520174782, 17683.115844207994, 381093.0, 386203.0, 386315.0, 386588.0, 386728.0, 51167.744161278955, 52057.21914171291, 52183.0, 52204.0, 52215.47784522182, 1078.4823284823485, 1086.136521465421, 1088.5264909764278, 1176.253079294637, 1205.3430880170329, 20170.89914550418, 28609.570856437585, 29746.702532974392, 29781.553276700433, 30015.0, 42265.366019510344, 43190.352144717224, 43219.35170972375, 43230.783846080565, 43279.13441731211, 305561.0, 307463.0, 308162.0, 308374.0, 308513.0, 38183.80908095553, 38463.615363846, 39431.60568394279, 39539.40690889696, 42651.36022959596, 29035.496627561337, 46289.53710462852, 47275.05449890914, 47502.76248618735, 47604.0, 34694.30611387808, 35884.84690918553, 36831.63168368389, 37110.25779484449, 38942.80528597339, 37231.06922326964, 37249.441258380604, 37518.624813751514, 37708.43437348497, 37875.242495150495, 35580.0, 36321.27357452889, 37406.62593374032, 37517.81241093777, 37523.2495350086, 31511.0, 33470.0, 33803.66196338005, 34545.30909381848, 34679.65320346764, 25441.10956116527, 25527.361815954006, 25646.487070258117, 25891.741082588935, 25980.090696825522], "value": 17084.468112769082, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.9972480220158, 360.81237756366704, 367.9392900171472, 373.611444098138, 393.64965180988924, 12416.627501174957, 16511.917440412795, 16600.418985335502, 16956.915215423905, 18061.63876722465, 13629.591112266624, 13632.318384080781, 14544.636384090376, 15616.84383156168, 15703.371865125382, 5067.189249720045, 5263.078961181797, 5268.0, 6459.870802583945, 6713.530052896299, 4084.97957510212, 6861.348171923684, 6899.6550172491425, 6904.551204171713, 6907.620080895549, 5579.246801681782, 6792.93207067928, 6825.180978282613, 6930.029795828563, 6934.445244380463, 6809.829754256134, 6843.486738494583, 6903.378695917391, 6913.965430172842, 6924.0, 6433.420992110732, 6589.077529145923, 6590.80227593173, 6592.077109204715, 6593.340665933416, 23264.65103023456, 23293.767062329498, 23634.527309453886, 23661.0, 23790.881045594833, 1952.3557226115347, 1980.2969945669367, 2034.7660019097698, 2038.1134206620168, 2051.0975170924894, 14103.0, 14271.14373137615, 14447.566573002827, 14448.71102577953, 14770.926145369205, 1687.8059023212365, 1689.1047744695331, 1744.058208567372, 1785.526835388623, 1803.6933721267285, 57620.71189644067, 74345.25654743491, 75903.0, 77763.22236777616, 80650.5967470159, 15275.312610932535, 16464.42374516886, 16602.0, 16933.15334233308, 17609.55976100582, 28669.846316905125, 28727.13818585446, 28736.0, 28766.712332876403, 28857.56713649297, 8304.256106217641, 8346.70786522481, 8447.577621118919, 8729.91270087291, 8770.3422243332, 6813.7955861324235, 6955.547889387275, 7060.823479413056, 7062.329078737512, 7095.964520177469, 7970.880436793453, 8296.917030829614, 8443.551370102725, 8499.575021248913, 8568.742937711879, 2749.3264150282907, 3235.7249633781394, 3295.8846440374473, 3346.0631023313513, 3356.7482438817187, 739.3567596191348, 824.2993455562844, 859.7248880358351, 874.361715947362, 913.488446469979, 16330.101844398434, 16358.0, 16618.58453538671, 17284.22221000058, 17480.65038699244, 839.5634270179595, 839.6053854688287, 847.174005344784, 893.9987214320004, 898.3217670658742, 7379.409647228316, 9118.616843501977, 9572.808543829084, 9616.75958101053, 9680.46757428334, 281481.0, 285840.0, 371565.0, 373717.0, 374296.0, 74847.0, 74890.0, 76613.0, 81101.53941533154, 81287.0, 889.4529864133511, 936.9859452108224, 942.4392486470539, 945.6501094595044, 988.980220395588, 15872.127033012834, 16023.839761602701, 16303.510894673178, 16507.504774856774, 16686.332546698482, 35451.82274088716, 36047.45928811018, 37591.24817503689, 39278.2144357117, 39648.603513965645, 47441.52558474371, 50858.0, 51689.48310516997, 51711.48288517217, 52833.20750188827, 7446.739364122446, 10047.698569042941, 10268.435236062089, 10306.793864122526, 11244.0, 11058.502367393647, 11870.287782733063, 11916.404179790803, 12647.494100235888, 13339.86660133425, 7372.741954031583, 7565.962170189334, 8286.58567071632, 10301.484925753532, 10693.57225710994, 10537.209709271989, 10632.521536531029, 10865.511052002521, 10949.178811589003, 11227.831582526433, 10665.200109991627, 10818.242723009314, 10911.727206819576, 11310.547578096784, 11358.148138889452, 10527.631532896312, 10739.731506712395, 10799.190060745632, 10884.7278818027, 11328.263662862217, 10892.727681808019, 10928.94535527349, 10946.671599852018, 11257.887421126012, 11299.887001130212], "value": 9326.839542821486, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.9075364724467, 1357.2128165663912, 1392.811970383998, 1608.0, 1625.6992456395576, 7265.782026539206, 7784.766457006292, 7805.0, 7810.179931107237, 7811.609419529029, 6504.577202481835, 7203.711851525945, 7400.962995185017, 7427.591482468462, 7677.347425468828, 2158.5574957133827, 2183.235867446389, 2183.6942828004094, 2183.8471307008517, 2197.824174066071, 2142.7750086240953, 2171.7936796004356, 2205.195103787122, 2210.7457642371173, 2213.7454192767796, 2169.240765731997, 2172.4460262633083, 2175.347395781267, 2177.9782202177935, 2215.645496720525, 2132.7547332056856, 2139.6148693235214, 2140.283005193262, 2142.4429648291402, 2146.9785302146934, 2124.6919196716544, 2157.8813165275906, 2167.100653228908, 2180.6728990651527, 2181.040342249405, 7700.498402811454, 7735.651895664709, 7739.380849532024, 7854.0, 7854.960725196337, 4210.494740631144, 4308.289132293168, 4310.913781724379, 4312.805923733439, 4314.158739045887, 2881.6686081100524, 2931.3990631920406, 3018.607581014476, 3020.7281344679086, 3027.1523973287512, 913.7121806630956, 966.120830044656, 977.184051317151, 980.01998001998, 990.8067926754286, 10280.074793268566, 10296.330738501973, 10312.535935882828, 10314.22643301763, 10319.0, 3927.783971881574, 4095.5904409559403, 4203.873883783492, 4212.431321771583, 4217.957820421757, 8765.167309105625, 8870.379073464796, 8872.201501864864, 8874.51190184546, 8887.822243555092, 4348.456442944632, 4357.8256869724855, 4358.411614432074, 4359.302511598129, 4365.9126817463475, 3523.361636838882, 3836.0985168485386, 3932.2135572885536, 3952.822123004472, 3966.861159859449, 3589.6667166342086, 3682.521272234646, 3737.831797569116, 3746.831392587286, 3850.3646898261472, 1192.3859212505567, 1223.5717498875322, 1230.2311055590255, 1230.7169351049308, 1242.0498318786135, 825.2325337436242, 843.5318398289008, 847.3433089355675, 868.9435186712843, 874.4971641306274, 5078.669886457443, 5106.463821298785, 5168.793248270103, 5177.8187763428095, 5264.9736751315995, 405.8072415602565, 408.19178027505706, 416.9950419489017, 417.6533477213905, 420.7959139817186, 3480.9825950870086, 3494.545709057806, 3499.9475007874903, 3552.9644703552635, 3657.3599620066384, 9029.41308814925, 9284.071592840663, 9313.068693130768, 9316.254699624014, 9357.906420935704, 9227.953860230657, 9229.169374756304, 9233.307501937381, 9233.445993240428, 9274.90725092754, 6993.615351155735, 7025.648717564101, 7063.89404158938, 7064.682089305994, 7071.8939215911805, 4925.1381008324115, 5011.32347133147, 5049.116404629249, 5071.54356107952, 5274.868128296824, 8310.21052999964, 8332.583370831555, 8480.660773569234, 8496.06543280251, 8656.48061116335, 8557.828843422973, 8711.736798164104, 8774.473531588124, 8789.560521974003, 8792.29661627081, 6478.28738838718, 6480.6435646038035, 6541.901871472027, 6677.6661166940485, 6727.125473688389, 7437.665305061393, 7524.924750752642, 7528.924710752823, 7529.510581812165, 7530.8493830122, 6534.640594767334, 6598.241202261609, 6600.0, 6607.339266073354, 6702.631355275506, 6200.441960223601, 6247.7192175604805, 6363.840903977438, 6416.294207637063, 6516.674166291572, 6113.877722445437, 6215.875682486416, 6222.81331560054, 6231.1276421300145, 6234.906476402767, 4541.364209010807, 4641.257398816173, 4655.6973796703105, 4670.229412146958, 4702.059588082328, 4624.421947256593, 4667.509911459248, 4688.695234809727, 4775.6657034007285, 4887.193613053949], "value": 3993.375083265196, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [271.9986400067999, 284.54756936471006, 284.8380789805377, 287.07847808534603, 289.7421295047408, 4606.5163157868365, 4720.221163508017, 4779.091972525222, 4790.520947905212, 4818.686785358949, 4585.403897493329, 4686.484486706459, 4692.671512994092, 4694.647901407391, 4761.928571071437, 3736.701063914894, 3743.3449146399407, 3746.831392587333, 3750.456183853353, 3752.155764952891, 3554.9697178492534, 3756.3989761638145, 3756.849726010956, 3758.7180961427866, 3771.2457508498273, 3321.485169798685, 3589.174489867332, 3732.328180927432, 3755.117547376364, 3767.8116094195316, 3709.6290370962956, 3719.6423305493436, 3723.2925744108534, 3730.850765969358, 3744.3821769408014, 3298.670132986706, 3302.702756751904, 3304.058343372127, 3309.8179600121985, 3323.7341012718925, 4438.7114837535455, 4596.632734141919, 4653.395058642389, 4653.674242803005, 4665.183592871268, 4242.4272723182285, 4261.573842615745, 4266.786660666985, 4290.841472802357, 4332.28517294646, 4982.651214414992, 5004.9749751251375, 5005.124103281911, 5031.22016087507, 5041.369828771403, 3405.540252065964, 3526.7531272810916, 3532.6820586147114, 3541.097020259843, 3569.1077230692326, 5195.7402129893735, 5210.7854161981, 5218.086834803932, 5218.817341393033, 5299.708516031656, 3653.0867283179205, 3654.798986055739, 3660.04838741929, 3660.176460296412, 3666.944995825065, 3485.588336723631, 3641.10792855752, 3700.4264339027495, 3703.925861500135, 3715.461258117612, 4170.77060761655, 4217.936730949038, 4222.9577704222565, 4223.028703398174, 4241.1941731071, 4989.60083193351, 4991.376077990251, 5009.348784657971, 5017.37282839645, 5039.370078740158, 1203.9458224379923, 1242.8632850386632, 1248.36333469931, 1259.3325537465157, 1277.7316763479773, 825.8678611422264, 840.7976593471394, 858.9613467393982, 862.7498025572639, 864.1099667342647, 4362.411074504901, 4376.277914144131, 4380.364847097153, 4383.49589797171, 4385.473743150778, 5090.287359769635, 5111.795528178905, 5119.411267704261, 5132.923006154836, 5180.585553155738, 4187.330027195634, 4353.934690979638, 4364.236258654786, 4366.912661746811, 4397.868063958086, 2681.839089654627, 2704.3915119098438, 2749.6150538924567, 2754.0, 2768.2387343480705, 4824.372831531879, 4848.8302909398, 4862.149123903303, 4876.609871210295, 4888.462269150391, 5010.423801262901, 5286.286351342519, 5314.70769107695, 5321.068812957717, 5372.946270537323, 4924.162892308316, 4926.605871530341, 4927.679700819435, 4962.528559786814, 4995.300657907823, 4935.309056731989, 5191.676122588867, 5198.9740051299505, 5267.367915850123, 5268.446813084724, 5048.59611231108, 5124.56441202502, 5152.0, 5158.819441319536, 5167.948320516747, 4954.653174277766, 4973.577245934136, 4977.054359671651, 4981.8007279709855, 4986.8753281168265, 3531.3820081485123, 3626.836792344298, 3630.546181727284, 3640.290143422007, 3669.7155995401395, 5100.974495127501, 5110.540051395392, 5118.769655365443, 5125.384953805567, 5167.58659307247, 5036.118679231193, 5084.0, 5093.821716239914, 5124.871878203075, 5127.282180494659, 4964.627652926118, 4998.275594919747, 5061.240813877947, 5106.719130447861, 5120.462351453044, 4751.311059896227, 4812.326274321527, 4943.110240156806, 4951.0, 4977.456988333483, 5122.795088196431, 5127.435982042047, 5131.666441681428, 5136.383633963799, 5148.0, 5020.648554601143, 5021.49785021495, 5032.672876263031, 5034.798608055637, 5036.179739345978], "value": 3772.0852166774284, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.4555209743573, 634.9079383489393, 652.4649787174512, 672.0926748888998, 725.0936329588015, 11447.828282575758, 12117.818232726506, 12123.515059397625, 12321.753564928697, 12344.197627154228, 12078.0, 12279.570215042475, 12330.630081097559, 12347.444365003574, 12356.0, 622.2626187967273, 745.2547452547466, 745.4781652843004, 769.0002996105069, 775.1434664695515, 745.3701622129292, 756.6935391166586, 761.8742907420269, 762.3405754022758, 762.4396068889362, 809.3686924199134, 810.5866008335732, 810.9351251899864, 811.5495899775622, 811.6753298680545, 652.1847690387016, 667.7896462614261, 806.6249194124731, 807.2855522862279, 807.7132617920612, 487.7853744352509, 491.14785846556197, 578.806099956515, 585.4350551717571, 589.1516216648013, 13476.86523134766, 13516.459341626323, 13519.256440895746, 13531.39108740109, 13531.729365412735, 12436.067294952823, 12761.234325940473, 12802.167859089222, 13429.66425839352, 13654.112482688593, 11740.882591174064, 11859.703507412298, 12054.638360849189, 12292.692682682915, 12452.377381130907, 4030.0932290234755, 4079.2453396121514, 4267.829286828523, 4276.123394704078, 4277.101808620194, 64547.67726161386, 64963.02555461672, 65034.0, 65353.99999999953, 65546.3445365545, 9908.801823963624, 10096.596136154472, 10411.219158563137, 10434.373937563618, 10487.265891387682, 16775.664486710197, 18143.818561814212, 18228.726569101473, 18238.08809559517, 18270.0, 6998.965005174941, 7007.668542976818, 7061.611611361424, 7077.292270772985, 7202.92797072033, 3726.4969229153717, 3746.6440688134585, 3767.1900541383734, 3788.242351529705, 3837.021559502309, 2939.6472423309338, 3070.5087186050123, 3079.7536197104178, 3087.9536806947913, 3091.211741006074, 516.8733660253187, 516.9043726910534, 517.7592419524939, 526.3263023330144, 541.0747621567165, 505.5172310443518, 524.4860037163601, 530.2110896683473, 538.8410418926426, 639.9520035997319, 7919.643616037292, 8438.831223375499, 8613.021025084781, 8645.351598630128, 8793.384463087523, 575.6804973239808, 597.6115524908844, 612.295859761278, 619.5013014523352, 630.760311081786, 3820.178661587772, 4220.746755194698, 4235.618794308527, 4289.270823959934, 4366.759828209479, 55697.0, 55878.720606397525, 55926.440735592936, 56000.719996399755, 57328.713356433786, 50406.49593504091, 51009.0, 74249.62875185697, 86315.56842215749, 87517.56241218753, 43632.78183609062, 45459.77270113694, 70862.9370559442, 74406.62796685981, 74682.0, 8239.876401854097, 8516.361272904433, 8576.099509551408, 8756.124387561193, 9042.50266235337, 43965.560344396145, 44064.77967610142, 44569.70466814893, 45073.0, 46391.53608463872, 62021.0, 62688.68655656875, 64098.679506602166, 66086.33913660802, 66316.33683663102, 11470.82793758111, 11567.363794991355, 11602.361870097226, 11653.76692466129, 11727.88272117302, 13102.541411050568, 13373.598792036255, 13401.0, 13634.0, 13639.318034098455, 10765.838512422477, 10780.083692885879, 10865.619703310345, 10913.508892099715, 11328.603498877499, 11186.32882027081, 11348.886511134782, 11510.59712910044, 12042.397880105784, 12189.57336493254, 11414.201005929837, 11508.424578771195, 11967.166826010915, 12094.0, 12095.637130886087, 9015.188633022797, 9075.2286055686, 9128.132827381389, 9183.632654693738, 9749.122578967927, 9065.954670226607, 10220.9475461934, 10314.41392425927, 10516.894831051592, 10533.473326333806], "value": 6437.064822444488, "unit": "score"}], "name": "dromaeo_css", "value": 6434.6827638207415, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 115.0, 115.0, 114.0, 114.0, 113.0, 114.0, 113.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 124.0, 130.0, 185.0, 124.0, 128.0, 148.0, 123.0, 164.0, 123.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 163.0, 162.0, 162.0, 161.0, 162.0, 160.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 103.0, 76.0, 77.0, 75.0, 75.0, 110.0, 79.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 130.0, 86.0, 85.0, 85.0, 119.0, 87.0, 86.0, 131.0], "value": 98.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 67.0, 65.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 82.0, 83.0, 83.0, 82.0, 83.0, 83.0, 81.0, 81.0, 81.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 148.0, 140.0, 148.0, 148.0, 129.0, 135.0, 133.0, 165.0, 133.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 174.0, 170.0, 173.0, 174.0, 176.0, 176.0, 171.0, 170.0, 170.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 68.0, 69.0, 71.0, 68.0, 67.0, 66.0, 67.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1548.3999999999999, "alertThreshold": 2.0}]} 11:27:33 INFO - Return code: 0 11:27:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:27:33 INFO - # TBPL SUCCESS # 11:27:33 INFO - Running post-action listener: _resource_record_post_action 11:27:33 INFO - [mozharness: 2016-08-19 18:27:33.516287Z] Finished run-tests step (success) 11:27:33 INFO - Running post-run listener: _resource_record_post_run 11:27:33 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 399282176; Read time: 0; Write time: 351620 11:27:33 INFO - TinderboxPrint: CPU usage
13.0% 11:27:33 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:27:33 INFO - TinderboxPrint: I/O write bytes / time
399,282,176 / 351,620 11:27:33 INFO - TinderboxPrint: CPU idle
8,328.4 (87.0%) 11:27:33 INFO - TinderboxPrint: CPU user
1,198.8 (12.5%) 11:27:33 INFO - TinderboxPrint: Swap in / out
0 / 0 11:27:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 117346304; Read time: 0; Write time: 123260 11:27:33 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 281935872; Read time: 0; Write time: 228360 11:27:34 INFO - Running post-run listener: _upload_blobber_files 11:27:34 INFO - Blob upload gear active. 11:27:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:27:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:27:34 INFO - (blobuploader) - INFO - Open directory for files ... 11:27:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:27:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:27:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:35 INFO - (blobuploader) - INFO - Done attempting. 11:27:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:27:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:27:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:36 INFO - (blobuploader) - INFO - Done attempting. 11:27:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:27:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:27:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:40 INFO - (blobuploader) - INFO - Done attempting. 11:27:40 INFO - (blobuploader) - INFO - Iteration through files over. 11:27:40 INFO - Return code: 0 11:27:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:27:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:27:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db1b7f8dcf588e89d772ae711a2f46eafd1957d0d08d5ab2bc155771649c239f680dde299bc994feb61b9348a11d009f2bc1894f306cc24a07655a5f9bc9cbdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc73e9eda9ee8e5ca002e3662947df3e34a8c68edeeaecde425812cbbd3334e92144c78205702c1d7c526aa485cdd6dc8d8ac6a509a330a80e86f9ce1c744570", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87391fb06bf22506c05907c6c99c3425c4c822c4a09003e45139ac722a42d1e4731424a8df28ba022e73fbb0f26f4e63063e6eaa63dc72beedd7ce2d9a535a51"} 11:27:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:27:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:27:40 INFO - Contents: 11:27:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db1b7f8dcf588e89d772ae711a2f46eafd1957d0d08d5ab2bc155771649c239f680dde299bc994feb61b9348a11d009f2bc1894f306cc24a07655a5f9bc9cbdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc73e9eda9ee8e5ca002e3662947df3e34a8c68edeeaecde425812cbbd3334e92144c78205702c1d7c526aa485cdd6dc8d8ac6a509a330a80e86f9ce1c744570", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87391fb06bf22506c05907c6c99c3425c4c822c4a09003e45139ac722a42d1e4731424a8df28ba022e73fbb0f26f4e63063e6eaa63dc72beedd7ce2d9a535a51"} 11:27:40 INFO - Running post-run listener: copy_logs_to_upload_dir 11:27:40 INFO - Copying logs to upload dir... 11:27:40 INFO - mkdir: /builds/slave/test/build/upload/logs 11:27:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.114145 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-19 11:27:40.324418) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 11:27:40.328405) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db1b7f8dcf588e89d772ae711a2f46eafd1957d0d08d5ab2bc155771649c239f680dde299bc994feb61b9348a11d009f2bc1894f306cc24a07655a5f9bc9cbdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc73e9eda9ee8e5ca002e3662947df3e34a8c68edeeaecde425812cbbd3334e92144c78205702c1d7c526aa485cdd6dc8d8ac6a509a330a80e86f9ce1c744570", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87391fb06bf22506c05907c6c99c3425c4c822c4a09003e45139ac722a42d1e4731424a8df28ba022e73fbb0f26f4e63063e6eaa63dc72beedd7ce2d9a535a51"} build_url:https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011503 build_url: 'https://queue.taskcluster.net/v1/task/N_TQkojZRHCDroRkQiKDQw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db1b7f8dcf588e89d772ae711a2f46eafd1957d0d08d5ab2bc155771649c239f680dde299bc994feb61b9348a11d009f2bc1894f306cc24a07655a5f9bc9cbdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc73e9eda9ee8e5ca002e3662947df3e34a8c68edeeaecde425812cbbd3334e92144c78205702c1d7c526aa485cdd6dc8d8ac6a509a330a80e86f9ce1c744570", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87391fb06bf22506c05907c6c99c3425c4c822c4a09003e45139ac722a42d1e4731424a8df28ba022e73fbb0f26f4e63063e6eaa63dc72beedd7ce2d9a535a51"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 11:27:40.357958) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:27:40.358603) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471630016.265325-57242213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:27:40.442895) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 11:27:40.443659) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 11:27:40.444332) ========= ========= Total master_lag: 0.16 =========