builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1472049055.27 results: success (0) buildid: 20160824060514 builduid: bb7ec8241dba458dae0632dfdfacddf4 revision: 01748a2b1a463f24efd9cd8abad9ccfd76b037b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 07:30:55.272833) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 07:30:55.273349) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 07:30:55.273638) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 07:30:55.288079) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 07:30:55.288366) ========= 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=232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-24 07:30:55-- 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% 38.7M=0s 2016-08-24 07:30:55 (38.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.355629 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 07:30:55.658869) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 07:30:55.659395) ========= 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=232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022747 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 07:30:55.709466) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 07:30:55.709845) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 01748a2b1a463f24efd9cd8abad9ccfd76b037b8 --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 01748a2b1a463f24efd9cd8abad9ccfd76b037b8 --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=232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-24 07:30:56,064 truncating revision to first 12 chars 2016-08-24 07:30:56,064 Setting DEBUG logging. 2016-08-24 07:30:56,064 attempt 1/10 2016-08-24 07:30:56,065 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/01748a2b1a46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-24 07:30:56,317 unpacking tar archive at: mozilla-central-01748a2b1a46/testing/mozharness/ program finished with exit code 0 elapsedTime=0.539786 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 07:30:56.265342) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 07:30:56.265727) ========= script_repo_revision: 01748a2b1a463f24efd9cd8abad9ccfd76b037b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 07:30:56.266304) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 07:30:56.266720) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 07:30:56.277352) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-24 07:30:56.277850) ========= /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=232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:30:56 INFO - MultiFileLogger online at 20160824 07:30:56 in /builds/slave/test 07:30:56 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 07:30:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:30:56 INFO - {'append_to_log': False, 07:30:56 INFO - 'base_work_dir': '/builds/slave/test', 07:30:56 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:30:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:30:56 INFO - 'branch': 'Firefox-Non-PGO', 07:30:56 INFO - 'buildbot_json_path': 'buildprops.json', 07:30:56 INFO - 'config_files': ('talos/linux_config.py',), 07:30:56 INFO - 'default_actions': ('clobber', 07:30:56 INFO - 'read-buildbot-config', 07:30:56 INFO - 'download-and-extract', 07:30:56 INFO - 'populate-webroot', 07:30:56 INFO - 'create-virtualenv', 07:30:56 INFO - 'install', 07:30:56 INFO - 'run-tests'), 07:30:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:30:56 INFO - 'download_minidump_stackwalk': True, 07:30:56 INFO - 'download_symbols': 'ondemand', 07:30:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:30:56 INFO - 'tooltool.py': '/tools/tooltool.py', 07:30:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:30:56 INFO - '/tools/misc-python/virtualenv.py')}, 07:30:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:30:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:30:56 INFO - 'installer_path': 'installer.exe', 07:30:56 INFO - 'log_level': 'info', 07:30:56 INFO - 'log_name': 'talos', 07:30:56 INFO - 'log_to_console': True, 07:30:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:30:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:30:56 INFO - 'opt_config_files': (), 07:30:56 INFO - 'pip_index': False, 07:30:56 INFO - 'sps_profile': False, 07:30:56 INFO - 'sps_profile_interval': 0, 07:30:56 INFO - 'suite': 'dromaeojs', 07:30:56 INFO - 'system_bits': '32', 07:30:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:30:56 INFO - 'title': 'talos-linux64-ix-025', 07:30:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:30:56 INFO - 'use_talos_json': True, 07:30:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:30:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:30:56 INFO - 'work_dir': 'build'} 07:30:56 INFO - [mozharness: 2016-08-24 14:30:56.728293Z] Running clobber step. 07:30:56 INFO - Running pre-action listener: _resource_record_pre_action 07:30:56 INFO - Running main action method: clobber 07:30:56 INFO - rmtree: /builds/slave/test/build 07:30:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:30:57 INFO - Running post-action listener: _resource_record_post_action 07:30:57 INFO - [mozharness: 2016-08-24 14:30:57.185145Z] Finished clobber step (success) 07:30:57 INFO - [mozharness: 2016-08-24 14:30:57.185246Z] Running read-buildbot-config step. 07:30:57 INFO - Running pre-action listener: _resource_record_pre_action 07:30:57 INFO - Running main action method: read_buildbot_config 07:30:57 INFO - Using buildbot properties: 07:30:57 INFO - { 07:30:57 INFO - "project": "", 07:30:57 INFO - "product": "firefox", 07:30:57 INFO - "script_repo_revision": "production", 07:30:57 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:30:57 INFO - "repository": "", 07:30:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:30:57 INFO - "buildid": "20160824060514", 07:30:57 INFO - "pgo_build": "False", 07:30:57 INFO - "basedir": "/builds/slave/test", 07:30:57 INFO - "buildnumber": 608, 07:30:57 INFO - "slavename": "talos-linux64-ix-025", 07:30:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:30:57 INFO - "platform": "ubuntu64_hw", 07:30:57 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:30:57 INFO - "branch": "mozilla-central", 07:30:57 INFO - "repo_path": "mozilla-central", 07:30:57 INFO - "revision": "01748a2b1a463f24efd9cd8abad9ccfd76b037b8", 07:30:57 INFO - "stage_platform": "linux64", 07:30:57 INFO - "builduid": "bb7ec8241dba458dae0632dfdfacddf4", 07:30:57 INFO - "slavebuilddir": "test" 07:30:57 INFO - } 07:30:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/d5wwQyZeQJCS_wRcGIsNhQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 07:30:57 INFO - Running post-action listener: _resource_record_post_action 07:30:57 INFO - [mozharness: 2016-08-24 14:30:57.187660Z] Finished read-buildbot-config step (success) 07:30:57 INFO - [mozharness: 2016-08-24 14:30:57.187748Z] Running download-and-extract step. 07:30:57 INFO - Running pre-action listener: _resource_record_pre_action 07:30:57 INFO - Running main action method: download_and_extract 07:30:57 INFO - mkdir: /builds/slave/test/build/tests 07:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:57 INFO - trying https://queue.taskcluster.net/v1/task/d5wwQyZeQJCS_wRcGIsNhQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:30:57 INFO - Downloading https://queue.taskcluster.net/v1/task/d5wwQyZeQJCS_wRcGIsNhQ/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 07:30:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d5wwQyZeQJCS_wRcGIsNhQ/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 07:30:57 INFO - Downloaded 1361 bytes. 07:30:57 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:30:57 INFO - Using the following test package requirements: 07:30:57 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:30:57 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:30:57 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:30:57 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:57 INFO - u'jsshell-linux-x86_64.zip'], 07:30:57 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:30:57 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:30:57 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:30:57 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:30:57 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:30:57 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:30:57 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:57 INFO - trying https://queue.taskcluster.net/v1/task/d5wwQyZeQJCS_wRcGIsNhQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:30:57 INFO - Downloading https://queue.taskcluster.net/v1/task/d5wwQyZeQJCS_wRcGIsNhQ/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 07:30:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d5wwQyZeQJCS_wRcGIsNhQ/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 07:30:58 INFO - Downloaded 20324482 bytes. 07:30:58 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 07:31:02 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 07:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:02 INFO - trying https://queue.taskcluster.net/v1/task/d5wwQyZeQJCS_wRcGIsNhQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:31:02 INFO - Downloading https://queue.taskcluster.net/v1/task/d5wwQyZeQJCS_wRcGIsNhQ/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 07:31:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d5wwQyZeQJCS_wRcGIsNhQ/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 07:31:03 INFO - Downloaded 20324482 bytes. 07:31:03 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 07:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:08 INFO - trying https://queue.taskcluster.net/v1/task/d5wwQyZeQJCS_wRcGIsNhQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:31:08 INFO - Downloading https://queue.taskcluster.net/v1/task/d5wwQyZeQJCS_wRcGIsNhQ/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 07:31:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d5wwQyZeQJCS_wRcGIsNhQ/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 07:31:09 INFO - Downloaded 14413981 bytes. 07:31:09 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 07:31: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')]} 07:31:09 INFO - trying https://queue.taskcluster.net/v1/task/d5wwQyZeQJCS_wRcGIsNhQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:31:09 INFO - Downloading https://queue.taskcluster.net/v1/task/d5wwQyZeQJCS_wRcGIsNhQ/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 07:31:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d5wwQyZeQJCS_wRcGIsNhQ/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 07:31:10 INFO - Downloaded 55755590 bytes. 07:31:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d5wwQyZeQJCS_wRcGIsNhQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:31:10 INFO - mkdir: /builds/slave/test/properties 07:31:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:31:10 INFO - Writing to file /builds/slave/test/properties/build_url 07:31:10 INFO - Contents: 07:31:10 INFO - build_url:https://queue.taskcluster.net/v1/task/d5wwQyZeQJCS_wRcGIsNhQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:31:11 INFO - Running post-action listener: _resource_record_post_action 07:31:11 INFO - Running post-action listener: set_extra_try_arguments 07:31:11 INFO - [mozharness: 2016-08-24 14:31:11.048974Z] Finished download-and-extract step (success) 07:31:11 INFO - [mozharness: 2016-08-24 14:31:11.049199Z] Running populate-webroot step. 07:31:11 INFO - Running pre-action listener: _resource_record_pre_action 07:31:11 INFO - Running main action method: populate_webroot 07:31:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:31:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:31:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:31:11 INFO - '--tppagecycles', 07:31:11 INFO - '7'], 07:31:11 INFO - 'tests': ['tsvgm']}}, 07:31:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:31:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:31:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:31:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:31:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:31:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:31:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:11 INFO - 'talos_options': ['--disable-e10s'], 07:31:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:31:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:31:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:11 INFO - 'talos_options': ['--disable-e10s'], 07:31:11 INFO - 'tests': ['damp', 'tps']}, 07:31:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:11 INFO - 'tests': ['damp', 'tps']}, 07:31:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:31:11 INFO - 'tests': ['dromaeo_dom']}, 07:31:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:31:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:31:11 INFO - 'tests': ['basic_compositor_video']}, 07:31:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:31:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:31:11 INFO - 'tests': ['a11yr', 07:31:11 INFO - 'ts_paint', 07:31:11 INFO - 'tpaint', 07:31:11 INFO - 'sessionrestore', 07:31:11 INFO - 'sessionrestore_no_auto_restore', 07:31:11 INFO - 'tabpaint']}, 07:31:11 INFO - 'other-e10s': {'tests': ['a11yr', 07:31:11 INFO - 'ts_paint', 07:31:11 INFO - 'tpaint', 07:31:11 INFO - 'sessionrestore', 07:31:11 INFO - 'sessionrestore_no_auto_restore', 07:31:11 INFO - 'tabpaint']}, 07:31:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:31:11 INFO - 'ts_paint', 07:31:11 INFO - 'tpaint', 07:31:11 INFO - 'sessionrestore', 07:31:11 INFO - 'sessionrestore_no_auto_restore', 07:31:11 INFO - 'tabpaint']}, 07:31:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:31:11 INFO - 'ts_paint', 07:31:11 INFO - 'tpaint', 07:31:11 INFO - 'sessionrestore', 07:31:11 INFO - 'sessionrestore_no_auto_restore', 07:31:11 INFO - 'tabpaint']}, 07:31:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:31:11 INFO - 'tests': ['a11yr', 07:31:11 INFO - 'ts_paint', 07:31:11 INFO - 'tpaint', 07:31:11 INFO - 'sessionrestore', 07:31:11 INFO - 'sessionrestore_no_auto_restore', 07:31:11 INFO - 'tabpaint']}, 07:31:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:31:11 INFO - 'tests': ['a11yr', 07:31:11 INFO - 'ts_paint', 07:31:11 INFO - 'tpaint', 07:31:11 INFO - 'sessionrestore', 07:31:11 INFO - 'sessionrestore_no_auto_restore', 07:31:11 INFO - 'tabpaint']}, 07:31:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:31:11 INFO - 'tests': ['tsvgx', 07:31:11 INFO - 'tsvgr_opacity', 07:31:11 INFO - 'tart', 07:31:11 INFO - 'tscrollx', 07:31:11 INFO - 'cart']}, 07:31:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:31:11 INFO - 'tsvgr_opacity', 07:31:11 INFO - 'tart', 07:31:11 INFO - 'tscrollx', 07:31:11 INFO - 'cart']}, 07:31:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:11 INFO - 'talos_options': ['--disable-e10s'], 07:31:11 INFO - 'tests': ['tp5o']}, 07:31:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:11 INFO - 'tests': ['tp5o']}, 07:31:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:11 INFO - 'talos_options': ['--disable-e10s', 07:31:11 INFO - '--xperf_path', 07:31:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:31:11 INFO - 'tests': ['tp5n']}, 07:31:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:11 INFO - 'talos_options': ['--xperf_path', 07:31:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:31:11 INFO - 'tests': ['tp5n']}}, 07:31:11 INFO - 'talos.zip': {'path': '', 07:31:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:31:11 INFO - Running post-action listener: _resource_record_post_action 07:31:11 INFO - [mozharness: 2016-08-24 14:31:11.066273Z] Finished populate-webroot step (success) 07:31:11 INFO - [mozharness: 2016-08-24 14:31:11.066361Z] Running create-virtualenv step. 07:31:11 INFO - Running pre-action listener: _resource_record_pre_action 07:31:11 INFO - Running main action method: create_virtualenv 07:31:11 INFO - Creating virtualenv /builds/slave/test/build/venv 07:31:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:31:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:31:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:31:11 INFO - Using real prefix '/usr' 07:31:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:31:11 INFO - Installing distribute.............................................................................................................................................................................................done. 07:31:13 INFO - Installing pip.................done. 07:31:13 INFO - Return code: 0 07:31:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb7b7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a62230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c090>, '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 0x2a5f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fe40>, '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': '232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:31:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:31:13 INFO - Using env: {'DISPLAY': ':0', 07:31:13 INFO - 'HOME': '/home/cltbld', 07:31:13 INFO - 'LANG': 'en_US.UTF-8', 07:31:13 INFO - 'LANGUAGE': 'en_US:en', 07:31:13 INFO - 'LOGNAME': 'cltbld', 07:31:13 INFO - 'MAIL': '/var/mail/cltbld', 07:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:13 INFO - 'MOZ_NO_REMOTE': '1', 07:31:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:13 INFO - 'NO_EM_RESTART': '1', 07:31:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:13 INFO - 'PWD': '/builds/slave/test', 07:31:13 INFO - 'SHELL': '/bin/bash', 07:31:13 INFO - 'SHLVL': '1', 07:31:13 INFO - 'TERM': 'linux', 07:31:13 INFO - 'TMOUT': '86400', 07:31:13 INFO - 'USER': 'cltbld', 07:31:13 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943', 07:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:13 INFO - '_': '/tools/buildbot/bin/python'} 07:31:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:31:13 INFO - Cleaning up... 07:31:13 INFO - Return code: 0 07:31:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fccb7b7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a62230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c090>, '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 0x2a5f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fe40>, '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': '232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:31:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:31:13 INFO - Using env: {'DISPLAY': ':0', 07:31:13 INFO - 'HOME': '/home/cltbld', 07:31:13 INFO - 'LANG': 'en_US.UTF-8', 07:31:13 INFO - 'LANGUAGE': 'en_US:en', 07:31:13 INFO - 'LOGNAME': 'cltbld', 07:31:13 INFO - 'MAIL': '/var/mail/cltbld', 07:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:13 INFO - 'MOZ_NO_REMOTE': '1', 07:31:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:13 INFO - 'NO_EM_RESTART': '1', 07:31:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:13 INFO - 'PWD': '/builds/slave/test', 07:31:13 INFO - 'SHELL': '/bin/bash', 07:31:13 INFO - 'SHLVL': '1', 07:31:13 INFO - 'TERM': 'linux', 07:31:13 INFO - 'TMOUT': '86400', 07:31:13 INFO - 'USER': 'cltbld', 07:31:13 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943', 07:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:13 INFO - '_': '/tools/buildbot/bin/python'} 07:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:14 INFO - Downloading/unpacking psutil>=3.1.1 07:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:31:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:31:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:31:16 INFO - Installing collected packages: psutil 07:31:16 INFO - Running setup.py install for psutil 07:31:16 INFO - building 'psutil._psutil_linux' extension 07:31:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:31:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:31:16 INFO - building 'psutil._psutil_posix' extension 07:31:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:31:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:31:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:31:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:31:16 INFO - Successfully installed psutil 07:31:16 INFO - Cleaning up... 07:31:16 INFO - Return code: 0 07:31:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:16 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 0x7fccb7b7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a62230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c090>, '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 0x2a5f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fe40>, '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': '232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:31:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:31:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:31:16 INFO - Using env: {'DISPLAY': ':0', 07:31:16 INFO - 'HOME': '/home/cltbld', 07:31:16 INFO - 'LANG': 'en_US.UTF-8', 07:31:16 INFO - 'LANGUAGE': 'en_US:en', 07:31:16 INFO - 'LOGNAME': 'cltbld', 07:31:16 INFO - 'MAIL': '/var/mail/cltbld', 07:31:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:16 INFO - 'MOZ_NO_REMOTE': '1', 07:31:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:16 INFO - 'NO_EM_RESTART': '1', 07:31:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:16 INFO - 'PWD': '/builds/slave/test', 07:31:16 INFO - 'SHELL': '/bin/bash', 07:31:16 INFO - 'SHLVL': '1', 07:31:16 INFO - 'TERM': 'linux', 07:31:16 INFO - 'TMOUT': '86400', 07:31:16 INFO - 'USER': 'cltbld', 07:31:16 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943', 07:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:16 INFO - '_': '/tools/buildbot/bin/python'} 07:31:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:31:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:31:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:31:18 INFO - Installing collected packages: mozsystemmonitor 07:31:18 INFO - Running setup.py install for mozsystemmonitor 07:31:18 INFO - Successfully installed mozsystemmonitor 07:31:18 INFO - Cleaning up... 07:31:18 INFO - Return code: 0 07:31:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:31: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')]} 07:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31: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')]} 07:31:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31: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', '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 0x7fccb7b7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a62230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c090>, '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 0x2a5f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fe40>, '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': '232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:31: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:31: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 jsonschema==2.5.1 07:31:18 INFO - Using env: {'DISPLAY': ':0', 07:31:18 INFO - 'HOME': '/home/cltbld', 07:31:18 INFO - 'LANG': 'en_US.UTF-8', 07:31:18 INFO - 'LANGUAGE': 'en_US:en', 07:31:18 INFO - 'LOGNAME': 'cltbld', 07:31:18 INFO - 'MAIL': '/var/mail/cltbld', 07:31:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:18 INFO - 'MOZ_NO_REMOTE': '1', 07:31:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:18 INFO - 'NO_EM_RESTART': '1', 07:31:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:18 INFO - 'PWD': '/builds/slave/test', 07:31:18 INFO - 'SHELL': '/bin/bash', 07:31:18 INFO - 'SHLVL': '1', 07:31:18 INFO - 'TERM': 'linux', 07:31:18 INFO - 'TMOUT': '86400', 07:31:18 INFO - 'USER': 'cltbld', 07:31:18 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943', 07:31:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:18 INFO - '_': '/tools/buildbot/bin/python'} 07:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:19 INFO - Downloading/unpacking jsonschema==2.5.1 07:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:31:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31:21 INFO - Downloading functools32-3.2.3-2.tar.gz 07:31:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:31:21 INFO - warning: no files found matching '*.txt' 07:31:21 INFO - no previously-included directories found matching 'build' 07:31:21 INFO - no previously-included directories found matching 'dist' 07:31:21 INFO - no previously-included directories found matching '.git*' 07:31:21 INFO - Installing collected packages: jsonschema, functools32 07:31:21 INFO - Running setup.py install for functools32 07:31:21 INFO - warning: no files found matching '*.txt' 07:31:21 INFO - no previously-included directories found matching 'build' 07:31:21 INFO - no previously-included directories found matching 'dist' 07:31:21 INFO - no previously-included directories found matching '.git*' 07:31:21 INFO - Successfully installed jsonschema functools32 07:31:21 INFO - Cleaning up... 07:31:21 INFO - Return code: 0 07:31:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:21 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 0x7fccb7b7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a62230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c090>, '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 0x2a5f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fe40>, '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': '232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:31:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:31:21 INFO - Using env: {'DISPLAY': ':0', 07:31:21 INFO - 'HOME': '/home/cltbld', 07:31:21 INFO - 'LANG': 'en_US.UTF-8', 07:31:21 INFO - 'LANGUAGE': 'en_US:en', 07:31:21 INFO - 'LOGNAME': 'cltbld', 07:31:21 INFO - 'MAIL': '/var/mail/cltbld', 07:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:21 INFO - 'MOZ_NO_REMOTE': '1', 07:31:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:21 INFO - 'NO_EM_RESTART': '1', 07:31:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:21 INFO - 'PWD': '/builds/slave/test', 07:31:21 INFO - 'SHELL': '/bin/bash', 07:31:21 INFO - 'SHLVL': '1', 07:31:21 INFO - 'TERM': 'linux', 07:31:21 INFO - 'TMOUT': '86400', 07:31:21 INFO - 'USER': 'cltbld', 07:31:21 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943', 07:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:21 INFO - '_': '/tools/buildbot/bin/python'} 07:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:31:21 INFO - Cleaning up... 07:31:21 INFO - Return code: 0 07:31:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:21 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 0x7fccb7b7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a62230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c090>, '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 0x2a5f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fe40>, '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': '232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:31:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:31:21 INFO - Using env: {'DISPLAY': ':0', 07:31:21 INFO - 'HOME': '/home/cltbld', 07:31:21 INFO - 'LANG': 'en_US.UTF-8', 07:31:21 INFO - 'LANGUAGE': 'en_US:en', 07:31:21 INFO - 'LOGNAME': 'cltbld', 07:31:21 INFO - 'MAIL': '/var/mail/cltbld', 07:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:21 INFO - 'MOZ_NO_REMOTE': '1', 07:31:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:21 INFO - 'NO_EM_RESTART': '1', 07:31:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:21 INFO - 'PWD': '/builds/slave/test', 07:31:21 INFO - 'SHELL': '/bin/bash', 07:31:21 INFO - 'SHLVL': '1', 07:31:21 INFO - 'TERM': 'linux', 07:31:21 INFO - 'TMOUT': '86400', 07:31:21 INFO - 'USER': 'cltbld', 07:31:21 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943', 07:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:21 INFO - '_': '/tools/buildbot/bin/python'} 07:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:21 INFO - Downloading/unpacking blobuploader==1.2.4 07:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:23 INFO - Downloading blobuploader-1.2.4.tar.gz 07:31:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:31:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:31:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:24 INFO - Downloading docopt-0.6.1.tar.gz 07:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:31:24 INFO - Installing collected packages: blobuploader, requests, docopt 07:31:24 INFO - Running setup.py install for blobuploader 07:31:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:31:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:31:24 INFO - Running setup.py install for requests 07:31:24 INFO - Running setup.py install for docopt 07:31:25 INFO - Successfully installed blobuploader requests docopt 07:31:25 INFO - Cleaning up... 07:31:25 INFO - Return code: 0 07:31:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb7b7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a62230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c090>, '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 0x2a5f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fe40>, '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': '232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:31:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:31:25 INFO - Using env: {'DISPLAY': ':0', 07:31:25 INFO - 'HOME': '/home/cltbld', 07:31:25 INFO - 'LANG': 'en_US.UTF-8', 07:31:25 INFO - 'LANGUAGE': 'en_US:en', 07:31:25 INFO - 'LOGNAME': 'cltbld', 07:31:25 INFO - 'MAIL': '/var/mail/cltbld', 07:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:25 INFO - 'MOZ_NO_REMOTE': '1', 07:31:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:25 INFO - 'NO_EM_RESTART': '1', 07:31:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:25 INFO - 'PWD': '/builds/slave/test', 07:31:25 INFO - 'SHELL': '/bin/bash', 07:31:25 INFO - 'SHLVL': '1', 07:31:25 INFO - 'TERM': 'linux', 07:31:25 INFO - 'TMOUT': '86400', 07:31:25 INFO - 'USER': 'cltbld', 07:31:25 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943', 07:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:25 INFO - '_': '/tools/buildbot/bin/python'} 07:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:31:25 INFO - Running setup.py (path:/tmp/pip-9llZ6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:31:25 INFO - Running setup.py (path:/tmp/pip-hVXaWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:31:25 INFO - Running setup.py (path:/tmp/pip-a9W4PN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:31:25 INFO - Running setup.py (path:/tmp/pip-Bt1fgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:31:25 INFO - Running setup.py (path:/tmp/pip-tUrAUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:31:25 INFO - Running setup.py (path:/tmp/pip-YZYZ3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:31:25 INFO - Running setup.py (path:/tmp/pip-JOAz08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:31:25 INFO - Running setup.py (path:/tmp/pip-ssw28J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:31:25 INFO - Running setup.py (path:/tmp/pip-4iD0ML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:31:26 INFO - Running setup.py (path:/tmp/pip-J_pzg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:31:26 INFO - Running setup.py (path:/tmp/pip-3xcgjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:31:26 INFO - Running setup.py (path:/tmp/pip-MTxsAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:31:26 INFO - Running setup.py (path:/tmp/pip-w7TB0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:31:26 INFO - Running setup.py (path:/tmp/pip-0eDCD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:26 INFO - Running setup.py (path:/tmp/pip-LT6ccr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:31:26 INFO - Running setup.py (path:/tmp/pip-pVv_jB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:31:26 INFO - Running setup.py (path:/tmp/pip-Whesqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:31:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:31:26 INFO - Running setup.py install for manifestparser 07:31:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:31:26 INFO - Running setup.py install for mozcrash 07:31:26 INFO - Running setup.py install for mozdebug 07:31:26 INFO - Running setup.py install for mozdevice 07:31:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:31:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:31:27 INFO - Running setup.py install for mozfile 07:31:27 INFO - Running setup.py install for mozhttpd 07:31:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:31:27 INFO - Running setup.py install for mozinfo 07:31:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:31:27 INFO - Running setup.py install for mozInstall 07:31:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:31:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:31:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:31:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:31:27 INFO - Running setup.py install for mozleak 07:31:27 INFO - Running setup.py install for mozlog 07:31:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:31:27 INFO - Running setup.py install for moznetwork 07:31:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:31:27 INFO - Running setup.py install for mozprocess 07:31:27 INFO - Running setup.py install for mozprofile 07:31:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:31:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:31:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:31:27 INFO - Running setup.py install for mozrunner 07:31:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:31:28 INFO - Running setup.py install for mozscreenshot 07:31:28 INFO - Running setup.py install for moztest 07:31:28 INFO - Running setup.py install for mozversion 07:31:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:31:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:31:28 INFO - Cleaning up... 07:31:28 INFO - Return code: 0 07:31:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:28 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 0x7fccb7b7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a62230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c090>, '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 0x2a5f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fe40>, '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': '232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:31:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:31:28 INFO - Using env: {'DISPLAY': ':0', 07:31:28 INFO - 'HOME': '/home/cltbld', 07:31:28 INFO - 'LANG': 'en_US.UTF-8', 07:31:28 INFO - 'LANGUAGE': 'en_US:en', 07:31:28 INFO - 'LOGNAME': 'cltbld', 07:31:28 INFO - 'MAIL': '/var/mail/cltbld', 07:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:28 INFO - 'MOZ_NO_REMOTE': '1', 07:31:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:28 INFO - 'NO_EM_RESTART': '1', 07:31:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:28 INFO - 'PWD': '/builds/slave/test', 07:31:28 INFO - 'SHELL': '/bin/bash', 07:31:28 INFO - 'SHLVL': '1', 07:31:28 INFO - 'TERM': 'linux', 07:31:28 INFO - 'TMOUT': '86400', 07:31:28 INFO - 'USER': 'cltbld', 07:31:28 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943', 07:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:28 INFO - '_': '/tools/buildbot/bin/python'} 07:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:31:28 INFO - Running setup.py (path:/tmp/pip-b6h1CL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:31:28 INFO - Running setup.py (path:/tmp/pip-Hv5IOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:31:28 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)) 07:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:31:28 INFO - Running setup.py (path:/tmp/pip-HUo5Xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:31:28 INFO - Running setup.py (path:/tmp/pip-3Yxjhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:31:28 INFO - Running setup.py (path:/tmp/pip-U1XLCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:31:28 INFO - Running setup.py (path:/tmp/pip-WtGAD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:31:29 INFO - Running setup.py (path:/tmp/pip-tQkgtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:31:29 INFO - Running setup.py (path:/tmp/pip-ILcrnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:31:29 INFO - Running setup.py (path:/tmp/pip-PTyqGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:31:29 INFO - Running setup.py (path:/tmp/pip-0ZhTdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:31:29 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)) 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:31:29 INFO - Running setup.py (path:/tmp/pip-j8KHrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:31:29 INFO - Running setup.py (path:/tmp/pip-hMc_pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:31:29 INFO - Running setup.py (path:/tmp/pip-x_w7Hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:31:29 INFO - Running setup.py (path:/tmp/pip-TWjPy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:31:29 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)) 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:29 INFO - Running setup.py (path:/tmp/pip-Ea3Ixg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:31:29 INFO - Running setup.py (path:/tmp/pip-NnQMQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:31:29 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)) 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:31:29 INFO - Running setup.py (path:/tmp/pip-Xi1API-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:31:29 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)) 07:31:29 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)) 07:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:31:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:31 INFO - Downloading blessings-1.6.tar.gz 07:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:31:31 INFO - Installing collected packages: blessings 07:31:31 INFO - Running setup.py install for blessings 07:31:31 INFO - Successfully installed blessings 07:31:31 INFO - Cleaning up... 07:31:31 INFO - Return code: 0 07:31:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:31:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:31:32 INFO - Reading from file tmpfile_stdout 07:31:32 INFO - Current package versions: 07:31:32 INFO - argparse == 1.2.1 07:31:32 INFO - blessings == 1.6 07:31:32 INFO - blobuploader == 1.2.4 07:31:32 INFO - docopt == 0.6.1 07:31:32 INFO - functools32 == 3.2.3-2 07:31:32 INFO - jsonschema == 2.5.1 07:31:32 INFO - manifestparser == 1.1 07:31:32 INFO - mozInstall == 1.12 07:31:32 INFO - mozcrash == 0.17 07:31:32 INFO - mozdebug == 0.1 07:31:32 INFO - mozdevice == 0.48 07:31:32 INFO - mozfile == 1.2 07:31:32 INFO - mozhttpd == 0.7 07:31:32 INFO - mozinfo == 0.9 07:31:32 INFO - mozleak == 0.1 07:31:32 INFO - mozlog == 3.3 07:31:32 INFO - moznetwork == 0.27 07:31:32 INFO - mozprocess == 0.23 07:31:32 INFO - mozprofile == 0.28 07:31:32 INFO - mozrunner == 6.12 07:31:32 INFO - mozscreenshot == 0.1 07:31:32 INFO - mozsystemmonitor == 0.3 07:31:32 INFO - moztest == 0.7 07:31:32 INFO - mozversion == 1.4 07:31:32 INFO - psutil == 3.1.1 07:31:32 INFO - requests == 1.2.3 07:31:32 INFO - wsgiref == 0.1.2 07:31:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:32 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 0x7fccb7b7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a62230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c090>, '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 0x2a5f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fe40>, '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': '232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:31:32 INFO - Using env: {'DISPLAY': ':0', 07:31:32 INFO - 'HOME': '/home/cltbld', 07:31:32 INFO - 'LANG': 'en_US.UTF-8', 07:31:32 INFO - 'LANGUAGE': 'en_US:en', 07:31:32 INFO - 'LOGNAME': 'cltbld', 07:31:32 INFO - 'MAIL': '/var/mail/cltbld', 07:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:32 INFO - 'MOZ_NO_REMOTE': '1', 07:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:32 INFO - 'NO_EM_RESTART': '1', 07:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:32 INFO - 'PWD': '/builds/slave/test', 07:31:32 INFO - 'SHELL': '/bin/bash', 07:31:32 INFO - 'SHLVL': '1', 07:31:32 INFO - 'TERM': 'linux', 07:31:32 INFO - 'TMOUT': '86400', 07:31:32 INFO - 'USER': 'cltbld', 07:31:32 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943', 07:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:32 INFO - '_': '/tools/buildbot/bin/python'} 07:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:31:32 INFO - Cleaning up... 07:31:32 INFO - Return code: 0 07:31:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb7b7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a62230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c090>, '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 0x2a5f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fe40>, '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': '232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:31:32 INFO - Using env: {'DISPLAY': ':0', 07:31:32 INFO - 'HOME': '/home/cltbld', 07:31:32 INFO - 'LANG': 'en_US.UTF-8', 07:31:32 INFO - 'LANGUAGE': 'en_US:en', 07:31:32 INFO - 'LOGNAME': 'cltbld', 07:31:32 INFO - 'MAIL': '/var/mail/cltbld', 07:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:32 INFO - 'MOZ_NO_REMOTE': '1', 07:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:32 INFO - 'NO_EM_RESTART': '1', 07:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:32 INFO - 'PWD': '/builds/slave/test', 07:31:32 INFO - 'SHELL': '/bin/bash', 07:31:32 INFO - 'SHLVL': '1', 07:31:32 INFO - 'TERM': 'linux', 07:31:32 INFO - 'TMOUT': '86400', 07:31:32 INFO - 'USER': 'cltbld', 07:31:32 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943', 07:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:32 INFO - '_': '/tools/buildbot/bin/python'} 07:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:31:32 INFO - Cleaning up... 07:31:32 INFO - Return code: 0 07:31:32 INFO - Running post-action listener: _resource_record_post_action 07:31:32 INFO - Running post-action listener: _start_resource_monitoring 07:31:32 INFO - Starting resource monitoring. 07:31:32 INFO - [mozharness: 2016-08-24 14:31:32.682827Z] Finished create-virtualenv step (success) 07:31:32 INFO - [mozharness: 2016-08-24 14:31:32.683423Z] Running install step. 07:31:32 INFO - Running pre-action listener: _resource_record_pre_action 07:31:32 INFO - Running main action method: install 07:31:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:31:32 INFO - Reading from file tmpfile_stdout 07:31:32 INFO - Detecting whether we're running mozinstall >=1.0... 07:31:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:31:32 INFO - Reading from file tmpfile_stdout 07:31:32 INFO - Output received: 07:31:32 INFO - Usage: mozinstall [options] installer 07:31:32 INFO - Options: 07:31:32 INFO - -h, --help show this help message and exit 07:31:32 INFO - -d DEST, --destination=DEST 07:31:32 INFO - Directory to install application into. [default: 07:31:32 INFO - "/builds/slave/test"] 07:31:32 INFO - --app=APP Application being installed. [default: firefox] 07:31:32 INFO - mkdir: /builds/slave/test/build/application 07:31:32 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'] 07:31:32 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 07:31:49 INFO - Reading from file tmpfile_stdout 07:31:49 INFO - Output received: 07:31:49 INFO - /builds/slave/test/build/application/firefox/firefox 07:31:49 INFO - Running post-action listener: _resource_record_post_action 07:31:49 INFO - [mozharness: 2016-08-24 14:31:49.044113Z] Finished install step (success) 07:31:49 INFO - [mozharness: 2016-08-24 14:31:49.044360Z] Running run-tests step. 07:31:49 INFO - Running pre-action listener: _resource_record_pre_action 07:31:49 INFO - Running main action method: run_tests 07:31:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:31:49 INFO - Python 2.7.3 07:31:49 INFO - Return code: 0 07:31:49 INFO - grabbing minidump binary from tooltool 07:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:49 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 0x2a5c090>, '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 0x2a5f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fe40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:31:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:31:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:31:49 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:31:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:31:49 INFO - Return code: 0 07:31:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:31:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:31:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:31:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:31:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:31:49 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/d5wwQyZeQJCS_wRcGIsNhQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:31:49 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/d5wwQyZeQJCS_wRcGIsNhQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:31:49 INFO - Using env: {'DISPLAY': ':0', 07:31:49 INFO - 'HOME': '/home/cltbld', 07:31:49 INFO - 'LANG': 'en_US.UTF-8', 07:31:49 INFO - 'LANGUAGE': 'en_US:en', 07:31:49 INFO - 'LOGNAME': 'cltbld', 07:31:49 INFO - 'MAIL': '/var/mail/cltbld', 07:31:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:31:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:49 INFO - 'MOZ_NO_REMOTE': '1', 07:31:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:31:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:49 INFO - 'NO_EM_RESTART': '1', 07:31:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:49 INFO - 'PWD': '/builds/slave/test', 07:31:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:31:49 INFO - 'SHELL': '/bin/bash', 07:31:49 INFO - 'SHLVL': '1', 07:31:49 INFO - 'TERM': 'linux', 07:31:49 INFO - 'TMOUT': '86400', 07:31:49 INFO - 'USER': 'cltbld', 07:31:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943', 07:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:49 INFO - '_': '/tools/buildbot/bin/python'} 07:31:49 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/d5wwQyZeQJCS_wRcGIsNhQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:31:49 INFO - mozversion application_buildid: 20160824060514 07:31:49 INFO - mozversion application_changeset: 01748a2b1a463f24efd9cd8abad9ccfd76b037b8 07:31:49 INFO - mozversion application_display_name: Nightly 07:31:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:31:49 INFO - mozversion application_name: Firefox 07:31:49 INFO - mozversion application_remotingname: firefox 07:31:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:31:49 INFO - mozversion application_vendor: Mozilla 07:31:49 INFO - mozversion application_version: 51.0a1 07:31:49 INFO - mozversion platform_buildid: 20160824060514 07:31:49 INFO - mozversion platform_changeset: 01748a2b1a463f24efd9cd8abad9ccfd76b037b8 07:31:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:31:49 INFO - mozversion platform_version: 51.0a1 07:31:49 INFO - using testdate: 1472049109 07:31:49 INFO - actual date: 1472049109 07:31:49 INFO - starting webserver on 'localhost:49363' 07:31:49 INFO - SUITE-START | Running 2 tests 07:31:49 INFO - TEST-START | dromaeo_css 07:31:49 INFO - operating with platform_type : linux_ 07:31:49 INFO - Initialising browser for dromaeo_css test... 07:31:49 INFO - TEST-INFO | started process 19864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFDecb_/profile http://localhost:49363/getInfo.html) 07:31:53 INFO - PROCESS | 19864 | __metrics Screen width/height:1600/1200 07:31:53 INFO - PROCESS | 19864 | colorDepth:24 07:31:53 INFO - PROCESS | 19864 | Browser inner width/height: 1024/697 07:31:53 INFO - PROCESS | 19864 | __metrics 07:31:54 INFO - PROCESS | 19864 | 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" 07:31:54 INFO - PROCESS | 19864 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:31:54 INFO - PROCESS | 19864 | console.error: PushService: 07:31:54 INFO - PROCESS | 19864 | stateChangeProcessEnqueue: Error transitioning state 07:31:54 INFO - PROCESS | 19864 | UnknownError 07:31:55 INFO - TEST-INFO | 19864: exit 0 07:31:55 INFO - Browser initialized. 07:31:55 INFO - Running cycle 1/1 for dromaeo_css test... 07:31:55 INFO - TEST-INFO | started process 19946 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFDecb_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:32:07 INFO - PROCESS | 19946 | RSS: Main: 181743616 07:32:07 INFO - PROCESS | 19946 | 07:33:00 INFO - PROCESS | 19946 | 1472049180038 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] 07:35:11 INFO - PROCESS | 19946 | Cycle 1(1): loaded http://localhost:49363/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49363/tests/dromaeo/cssquery-ext.html) 07:35:12 INFO - PROCESS | 19946 | RSS: Main: 276692992 07:35:12 INFO - PROCESS | 19946 | 07:38:15 INFO - PROCESS | 19946 | Cycle 1(1): loaded http://localhost:49363/tests/dromaeo/cssquery-ext.html (next: http://localhost:49363/tests/dromaeo/cssquery-jquery.html) 07:38:16 INFO - PROCESS | 19946 | RSS: Main: 269955072 07:38:16 INFO - PROCESS | 19946 | 07:41:18 INFO - PROCESS | 19946 | Cycle 1(1): loaded http://localhost:49363/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49363/tests/dromaeo/cssquery-mootools.html) 07:41:18 INFO - PROCESS | 19946 | RSS: Main: 262868992 07:41:18 INFO - PROCESS | 19946 | 07:44:21 INFO - PROCESS | 19946 | Cycle 1(1): loaded http://localhost:49363/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49363/tests/dromaeo/cssquery-prototype.html) 07:44:21 INFO - PROCESS | 19946 | RSS: Main: 218288128 07:44:21 INFO - PROCESS | 19946 | 07:47:25 INFO - PROCESS | 19946 | Cycle 1(1): loaded http://localhost:49363/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49363/tests/dromaeo/cssquery-yui.html) 07:47:25 INFO - PROCESS | 19946 | RSS: Main: 219570176 07:47:25 INFO - PROCESS | 19946 | 07:50:28 INFO - PROCESS | 19946 | Cycle 1(1): loaded http://localhost:49363/tests/dromaeo/cssquery-yui.html (next: http://localhost:49363/tests/dromaeo/cssquery-dojo.html) 07:50:28 INFO - PROCESS | 19946 | RSS: Main: 315568128 07:50:28 INFO - PROCESS | 19946 | 07:50:28 INFO - PROCESS | 19946 | __start_tp_report 07:50:28 INFO - PROCESS | 19946 | _x_x_mozilla_page_load 07:50:28 INFO - PROCESS | 19946 | _x_x_mozilla_page_load_details 07:50:28 INFO - PROCESS | 19946 | |i|pagename|runs| 07:50:28 INFO - PROCESS | 19946 | |0;dojo.html;2495.15164843953;2509.7615726505983;2526.3431507807963;2544.1095616534217;2554.540182767101;4521.276595744682;4577.427821522309;4579.908401831962;4605.194091034068;4614.930776038362;4626.282926146444;4637.698549594283;4687.554682305184;4699.85900422987;4700.459447163577;4224.61978421942;4262.488501379838;4287.421198138242;4341.175176716414;4409.955900441003;4309.892252693692;4361.563843615629;4372.3878656988045;4406.118776244748;4432.180046691373;4173.979130104361;4227.070044590185;4264.57354264571;4279.764612946318;4309.052008558112;4261.275583150872;4273.551277115889;4378.715383500063;4385.342198670193;4397;4296.334068219431;4321.135772845412;4322.286822674255;4364.367166760802;4367.213901497729;4568.794404251817;4688.484266730657;4723.937114149289;4727.196376615949;4730.810767569293;4877.439094504142;4932.358793356877;4942.258661200813;4944.159492886218;4946.703197808143;4920.40955085392;4951.009798040406;4960.082384758795;4972.627052971042;5023.397192336906;4595.080983803253;4631.513691062457;4631.6294696424875;4634.096351211481;4641.628669706415;5063.822766203165;5113.0285245803925;5119.6160287978555;5123.180291153398;5195.7142357170715;4923.753812309442;4941.925871111936;4942.456329803718;4945.4807245238735;5009.799608015712;4887.535684110004;5014.222795466709;5016.698998060128;5021.322121513549;5028.974855125774;4908.509149085135;4956.058348913695;4963.751812409365;4968.00639872027;5031.245313203049;4915.827946021872;4932.704037757746;4936.851894443173;4959;5001.8499445016705;4094.651954583834;4235.02594403289;4246.957530424718;4248.065425606362;4307.590778876001;3631.94552081719;3638.290533346025;3639.727020473475;3726.7950262735267;3752.0432289765936;4173.561776013536;4175.749455032707;4176.686748493875;4183.686223533247;4211.894702632459;4910.558049775537;4923.335349727812;4924.655274130848;4929.0881186979805;4970.801167953314;4135.214309281227;4144.3990621360335;4179.707420480598;4193.119444916601;4197.958020419818;4473.821047158142;4489.865304040884;4500.887477813081;4534.795934182904;4546.181687296253;4675.08835777027;4677;4680.92978605328;4684.0866031123605;4743.075100355398;4761;4937.308776771327;4992.800287988585;4996.750162491788;5005.499450054966;4664.906701866012;4685.320628508915;4690.249560070372;4730.597899178609;4741.525847415231;4910.091633047898;4928.088303663833;4931.728754918514;4934.383202099738;4982.427020892644;4877.146499362669;4914.164592019437;4970.204767237225;4971.552560269593;4996;4765.642576806684;4778.522147785194;4799.544043315879;4842.539958703917;4860.270959356125;4798.352222449925;4810.927836082532;4825.662203645851;4827.806887724451;4869.756512174448;4639.814407423665;4715.740634265148;4737;4796.184648609675;4817.421909370898;4892.828750993698;4908.754562271801;4911.091448082117;4916.70499770015;4952.653314267966;4817.13291607514;4818.68678535894;4818.927716084191;4863.392075990501;4872.805087796449 07:50:28 INFO - PROCESS | 19946 | |1;ext.html;570.603430615722;571.4542611805726;583.6060659055137;584.780707234787;585.5754577930999;28591;38738.612613873855;39751.801240993824;39786.20427591447;44363.778181109046;40616.59383406165;41026;41065.79467102668;41092.99999999993;41110.17779644413;7659.57872317021;7807.063152421689;7813.882791758099;7814.53112813233;7817.843643127134;7458.962705186466;9698.321117521777;9922.355046921963;9932.155766759834;10318.329308594955;10130.544125514332;10227.874933757317;10228.079472847443;10232.590696372174;10241;9968.700938971842;10010.649627263083;10047.648332308407;10053.69838904834;10063.396196228177;9778.119969202735;9847.655332063416;9848.852267215998;9851.950740246324;9856.556454959473;36872.44691329632;37138.814305928565;37162.44256336157;37212.25575488475;37300.44049339235;3013.7136971987625;3157.258044359574;3399.5410619566287;3401.897943061712;3734.3942104894886;28710.282242943886;28879.566806497918;28990.71009289901;29110;30519.084427467213;3347.397468455677;3535.275268569963;3540.964590354089;3565.5721313442295;3598.964010359889;183981;184102;185072;185354;186419.99999999863;31108.377832443224;51568.74215628898;51784.74107629513;51971.48028519667;51998.22002669963;31443;33196.66803331984;33222.50166247508;33257.83371083129;33262.16844578905;11486.42567871603;11543.538258469735;11550.249233799776;11551.826722599168;11562.76874462506;9302.627894884265;9604.03959604034;9774.12032917041;9783.119519243302;9785.36395134314;7794;7806.804829879298;7893.486923349964;7907.604619768988;7917.722879699183;3042.9543556846666;3072.4623190941497;3072.63128424586;3075.384923015406;3077.353755711326;876.8071024374627;893.6380765789866;926.5737760630051;928.1414691410419;957.913787759105;26460.867695661782;27509.724902751117;28354.736274490275;28936.855315723707;29029.41941161165;904.8326059678981;907.3829795738961;943.6272672294406;946.6781294359951;1003.4982508745627;14875.925620372045;14977.625559360886;15074.472393466176;15116.470923517623;15417.229138543027;380932;382411;383253;383607;385553;46990.76504617455;47418.28872566914;47609;47644.52355476401;47663.76168119137;1073.9892601074046;1145.5017067575632;1169.1348402182493;1181.527389044389;1195.235049568277;26541.867290663424;27902.3024424391;29082.854585726935;29285.26786830261;29461.433477810973;40666.59333406628;41160.38259426051;41169;41179.1764164709;41206.38190427206;296499;298914;299029;299095;299670;24522.632160517962;25348.11281605135;25394.619080714172;26471.73528264693;26545.867270663523;40687.593124069565;40816.59183408128;40873.38689919594;41193.38209926793;41588;34736;34765.30469390649;34843;34988.47517287294;35026.299474009866;34769.826150869085;35004.64995350116;35277.82361088178;35314.82342588271;35355.82322088476;34577;34751.82624086965;35266.82366588151;35391.646083538835;35593.288134237686;30912.381752364377;32618;32751;32751.672483274862;32825.83587082049;24715.62926556067;24734.134305299227;25024.49951001006;25303.87348063248;25582.360440989123 07:50:28 INFO - PROCESS | 19946 | |2;jquery.html;342.8804951832266;368.5135620980307;373.7141087068393;373.77013136920795;387.1888393814958;12964;16301.592460188502;16417.835821641795;16860.83139168608;17971.371002014934;16699;16829.83170168298;17416.912915435438;17526.64946701065;17537.824621753778;4961.925571116436;4968.900621987558;5134.229865520165;5161.458046905059;5163.277141200216;3745.587985321626;4959.578435832958;5040.294358789773;5770.798022069229;6074.605150665215;6047.576669633106;6054.182685337489;6061.939380606182;6062.787802426916;6126.571140020201;5911.763529458816;5975.073863551135;6008.639481631072;6017.428344307284;6030.306514750816;5166.664166829144;5338.706371149585;5343.519083282523;5352.491513306269;5353;21131.683024754642;21431.24990625336;21468.141274349007;21574.568508629898;21652.35042948714;1821.298799962011;1832.8075552066973;1880.64267789121;1986.4040787763613;2106.757722861875;12829.743405131938;13457.596272111852;13551;13720.108192967426;14204.715905681931;1730.1522254095528;1732.896026238417;1748.1521462090875;1757.3234304792747;1777.6000399910047;69294.65352673204;69966.65016674934;71187.64406177988;72546.27453725501;74383.62808185979;9769.706908792748;9790.069943355513;10137.391756494633;10189.745256368502;10426.270161088803;13925.303734813422;13937.58187254384;13943.372548235353;13945.511907083204;13957.441702331793;7227.457940654472;7241.674124664402;7320.67056982437;7575.659095340613;7583.886241706379;6916.100906882073;6937.54905931123;6984;7144.678489467987;7173.246809085075;6126.448619624255;6315.968420157962;6361.14124593174;6380.968095159495;6530.542861999709;1791.3461586521087;1812.9728054079199;1823.6170404215263;1832.688442964699;1837.5130590393555;824.8638974569249;842.1957031035347;861.5046348349724;909.0909090909091;928.132196396358;16491.505254842374;16849.32602695903;17279.82720172782;17789.288428462976;17907.820921790615;853.5262929074299;858.403409630301;878.6309749905055;902.3999040637902;925.0287198441744;9784.364016339057;10407.739806504898;10422.270441069053;10538.89461105379;10583.153347732163;368075;374526;375977;378015;378037;68874.3112568878;69696.24800293757;71203.28796711967;71240.64379678069;72235;938.6057855700623;989.604158336671;998.3161534348849;1004.4174378860243;1009.3187098708343;15450.22748862575;15896.125713085892;15901.60245993813;16056.43802466908;16494;33463.33073338471;33942.66057339395;34069.48895766516;35071;35740.10649733777;42697;44400.555994439645;45850.77074614605;46160.30759538677;46207.76896115498;4677.508861569486;6808.62552559614;7465.514741541782;7587.772366829004;7878.645460954156;12262.509499619915;12499;12535.749285014432;12554.937225313815;12612.369381530703;4788.281757736368;6877.38103570661;10384.532696028546;10472.476376181008;10858.13134949218;4505.121501307213;6975.40709039717;9910.959349268223;10552.525136369035;11100.11199104086;10793.352398856094;10858.837117443403;11231.943840280746;11280.379579122899;11285.774284514428;7908.3673306136525;8083.757487275391;8107.175885425968;8145.6334464950405;8192.221738934792;10660.413677247516;10817.405042722727;10836.13310935139;11322.60370887015;11428.085753139563 07:50:28 INFO - PROCESS | 19946 | |3;mootools.html;1264.7027948432124;1375.7248550289944;1388.6320125166828;1473.4990103364853;1642.187117376898;7250.238724933878;7447.553146811195;7577.924220757791;7802;7802.180771019046;7628.160902300742;7737.148913619511;7746.302832745052;7751.418643601738;7756.728514501993;1690.7632931389614;1986.4835142862887;2150.2796563151364;2174.695542624034;2175.7824217578273;2180.5856887191385;2209.4034610655194;2211.8341124415733;2221.8777967211795;2226.220822712054;2130.9893450532804;2148.2051640892814;2152.461884528868;2158.5251244726137;2193.385851961453;2012.8792272463627;2019.0207749241533;2022.2012305139535;2062.1957436599737;2145.839062070351;2134.7865213478685;2140.1332460353583;2147.1304121830526;2148.7206663133693;2149.967750483744;7839.568823714693;7864.4888082274465;7881.369490440751;7886.250806173404;7888.211178882066;4292.5063617683745;4419.823207071746;4427.667924905645;4430.579094985971;4431.246688063037;2844.630198074237;2895.319599894023;2984.6567644720917;2986.8506574671396;3003.039027511197;891.7681402835309;944.759086432962;960.582146766159;962.2782912815388;967.3663750243602;10160;10239.897601024044;10306.536205870754;10329.84505232422;10356.689299320957;3766.9434958475645;3817.2365526894732;3994.2211268802303;4027.8993025174605;4068.4100805383055;8251.876221856677;8264.256216940505;8275.668973241123;8283.958580207182;8286.544240066854;4334.501532323823;4375.299952007664;4381.539938306432;4385.802638881258;4385.824567017284;3408.1309266137473;3920.2747491714126;4033.4151548025957;4034.7579145250793;4052.675785937118;3222.2749881276527;3265.804051756902;3359.177001634615;3374.6119196292248;3386.205311185076;1030.7989941961246;1032.7279984035154;1039.1738567838586;1047.1256500821898;1061.395004847245;807.7657479330928;814.9062857771314;815.2173913043545;821.4947807098591;830.5058490198322;5026.924596131061;5034.6727462715535;5085.474357692678;5142.460041695643;5275.103232450492;393.2037623811804;395.9109200429938;398.6890225624018;398.8105649816372;399.1020204539785;3512.0693016350688;3545.3441113393587;3628.38317486028;3702.907857060752;4054.6958978076173;9691.12779849817;9713.70858874235;9826.263030272758;9857.30998830075;9875.160611347972;9747.122758951728;9754.512274386252;9760.414375137372;9778.119969202806;9788.119069283799;6874.759383421656;7276.890846637305;7446.73936412223;7461.216572259943;7471.364933980563;5069.949300507095;5187.792488300426;5226.477352264743;5375.704336261387;5540.196671482532;8710.346723995599;8895.822083558163;8997.550122493718;9014.909850901407;9060.456372617664;9000.234980026771;9034.683786067457;9193.172614464731;9198.172164505228;9204.769880753034;5848.707564621667;6556.508261880474;6660.500462465237;6668.533202675766;6670.433013193933;7272.490925635367;7341.6696248670005;7433.479656423999;7610.124835643972;7620.771376858703;6719.697613607302;6728.596284222962;6782.898256526255;6846.281140480377;6895.138107736533;6387.137736405526;6428.582142160744;6461.644609546332;6625.536212465081;6634.535582509178;6211.627302361872;6331.810045698637;6335.429811317003;6339.841503962253;6345.333739957238;4520.525344838876;4653.813847446064;4655.1387993220005;4660.067986402665;4710.481846996896;4507.1887060328145;4577;4669.673122881366;4702.177119004092;4830.951690483191 07:50:28 INFO - PROCESS | 19946 | |4;prototype.html;289.5237334584608;296.9896053638123;297.31913917129776;302.9954550681739;303.80101033822825;4673.929891051628;4777.546133117357;4789.976050119749;4793;4805.471398146201;4582.633389328854;4685.789139488723;4719.65489835397;4719.929201061978;4743.193657078296;3781.9621803781884;3789.658930696237;3792.146766977429;3795.0891785971444;3819.8281077351585;3568.4290513517844;3591.964080359189;3794.146317078649;3819.9045023874487;3830.8276127574186;3763.454299126625;3769.604191559874;3771.189828882138;3773.2264885698505;3778.8677396291137;3749.568799588041;3776.8866933992026;3777.565579958285;3784.867529636463;3787.9431808522895;3341.816200108993;3348.7990720556845;3354.9161270968175;3356.781809182395;3384.7799893006877;4585.335126406652;4631.3516107744945;4652.767361631905;4656.580907718288;4659.603933665642;4287.764172970486;4293.935590966138;4306.956930430687;4326.697131200817;4337.175936572041;4990.226514890198;5025.597952163818;5040.823571175028;5045.217991211368;5053.216751403538;3585.9959211420583;3661.304352173105;3673.2286219893854;3697.8705745298785;3704.8329776120436;5088.872778180538;5093.592512599021;5100.404215028396;5124.898146898435;5259.158534634478;3685.391910334765;3695.519582454264;3696.4270538066644;3696.7597106188014;3706.424769473017;3763.3790424580184;3779.3764028934916;3787.1289603390824;3804.562475315319;3808.3906574947873;4097.97951010243;4180.519240287406;4198.958010419918;4213.662906967435;4216.494020717533;4862.78117484714;4875.390576177978;4889.755512224375;4913.926291105637;4926.162552366106;1247.4137155536882;1277.8435515858164;1279.9168054076456;1284.0947132271726;1320.320035181882;860.1140824950311;876.7764220123828;888.8711136885115;915.9816803663889;917.7934964632905;4291.004682822502;4295.37717031035;4297.5702429756775;4297.634701050383;4354.499232588293;5095.949040509621;5147.176451767699;5148.819791307286;5158.432572417031;5171.069207542679;4187.371894215892;4396.560343965578;4416.624586910084;4438.201123797748;4439.334099884978;2751.1333929812045;2765.1566272287146;2767.6955534891144;2775.5004099261923;2779.471290790098;4705.505921878222;4849.4908034656555;4853.344798452164;4863.221884498464;4883.438404583448;5241.895162096736;5274.630775845654;5289.894202115936;5301;5310.548603368757;4843.951560484421;4848.296996935424;4854.975725121351;4858.319835223072;4889.535494128052;4926.068988951568;5202.1416466282635;5212.478752124909;5212.791488340576;5236.214567814706;5051.6716413433005;5063.164577844762;5067.87330316745;5079.87300317495;5084.872878178076;4802.327674125555;4828.744526423085;4842.394700662418;4846.878828029327;4854.975725121351;3693.6306369362846;3726.6646001859963;3777.3578491655935;3780.8109594519615;3798.4112462568346;5117.130087884994;5129.6665716729785;5131.358580177478;5132.384113906355;5137.229415587692;4967.801287948441;4975.457608141488;4978.352814134139;4993.201087825931;5037.269595908646;4807.903841923212;5001.674891132065;5011.924821127613;5037.773300201573;5055.393352797688;4704.976475117603;4815.879603009953;4849.903001940012;4879.829205977774;4926.458089610069;5047.141985862486;5056.8988620226655;5060.291559181644;5065.746712664279;5077.060743762416;5003.3495645565845;5005.824796132263;5008.599312055099;5020.598352131748;5022.824201152942 07:50:28 INFO - PROCESS | 19946 | |5;yui.html;600.3696119074973;608.2791891608443;640.2317219336795;656.7438698907426;733.380293651864;12255.325957072357;13397.7990330145;13579.456821727132;13580.524681636145;13586;13612.591622251324;13684.726305473909;13751.724965500684;13752.518661846838;13764.449422023132;617.3887851027496;738.9261073892621;741.0773586884336;758.8861670749377;760.3612965109307;764.533634482965;771.3250905457725;774.6126936531734;775.3603277296253;776.0144616337249;816.0615292413742;816.5182542300042;817.7015389382892;817.7464985854374;817.8650522663783;643.2634633344841;661.2329697550866;808.7695006923028;808.8544062068826;809.8663720486113;490.08843550995476;491.32933545709847;560.1457776890235;575.91937128802;579.5016285994042;12407.25556466615;12440.75118497625;12453.128281020332;12461.501539938483;12464.875351246463;12409;12575.308358040304;12970.87029129706;13089.280089595068;13448.529301474402;11472.31166130035;11535.711607209803;11598.246114002563;11783.64649060521;12201.450934707871;3983.661388781928;4038.29329867275;4064.8983775405554;4075;4118.094019315746;64728;64858.675706621165;65095;65141;65951;9660.565274562661;9829.655962041294;10061.949690251502;10271;10434.947825260977;17581.648367032845;19054.61890762177;19202.51993700141;19211.711824322647;19253.61492770137;6887.276835932155;6903.5167538271835;6984.3364880336285;7034.2262351141335;7097.858042839114;3665.9633403666157;3761.6426439488205;3762.830672619739;3790.8294126764363;3880.2821478026653;2931.6335458067742;3074.9538756918664;3078.122735020553;3078.6921307869034;3079.92300192497;516;516.1045585908446;516.333929231295;521.8434469659087;533.2108479450358;541.2071315522778;548.4159370270648;589.7935722497092;600.1358044416027;622.5828694774511;8103.392245581605;8263.95868020656;8331.50010999342;8525.488470691778;8542.914570854336;496.94036715593637;527.3434573955374;533.3120274845484;545.3837164004728;573.9713014349265;3748.887533374003;3790.566253045107;3872.96127038726;4006.338954072545;4008.659263962596;56149.43850561524;95482;101653;104414;106055.46972265089;52502.44750354693;52562.211566826525;52607.73696131571;87434;89653.55173224091;69445.65277173581;77996.61001695068;79795;80383;80421.19578804255;7406.8148296290865;7696.538207707556;7808.6876524940635;7838.412119091205;7840.609258815081;31822.635472905975;45494;46248.537514624426;46973.76513117413;46983.53016469791;63128.265380095756;68724.31275687179;69936.65031674808;70107.29892701212;73677.26322736705;10010;10034.949825250827;10063.849042264226;10256.897431025594;10303.3817970922;11999;12104.75790484203;12122.27266364021;12353.258804471761;13126.556078831512;10157.9492102539;10571.2600117991;10602.787944241227;10948.726281843017;11068.059214966817;10167.847482287623;10226.948865255627;10478.947605261925;10671.839922401015;10833.729156770829;10237.590496380062;10396.16830653561;10530;10568;10867;8479.576021198793;8736.78158046054;8773.473591584525;8997.235235005099;9542.141207291377;8006.359491240803;8694.260987816106;8722.607482663423;8777.473351598925;8791.648334066822 07:50:28 INFO - PROCESS | 19946 | __end_tp_report 07:50:28 INFO - PROCESS | 19946 | __start_cc_report 07:50:28 INFO - PROCESS | 19946 | _x_x_mozilla_cycle_collect,968 07:50:28 INFO - PROCESS | 19946 | __end_cc_report 07:50:28 INFO - PROCESS | 19946 | __startTimestamp1472050228930__endTimestamp 07:50:28 INFO - PROCESS | 19946 | 07:50:28 INFO - PROCESS | 19946 | ------- Summary: start ------- 07:50:28 INFO - PROCESS | 19946 | Number of tests: 6 07:50:28 INFO - PROCESS | 19946 | 07:50:28 INFO - PROCESS | 19946 | [#0] dojo.html Cycles:165 Average:4594.62 Median:4727.20 stddev:491.53 (10.4%) stddev-sans-first:464.63 07:50:28 INFO - PROCESS | 19946 | Values: 2495.2 2509.8 2526.3 2544.1 2554.5 4521.3 4577.4 4579.9 4605.2 4614.9 4626.3 4637.7 4687.6 4699.9 4700.5 4224.6 4262.5 4287.4 4341.2 4410.0 4309.9 4361.6 4372.4 4406.1 4432.2 4174.0 4227.1 4264.6 4279.8 4309.1 4261.3 4273.6 4378.7 4385.3 4397.0 4296.3 4321.1 4322.3 4364.4 4367.2 4568.8 4688.5 4723.9 4727.2 4730.8 4877.4 4932.4 4942.3 4944.2 4946.7 4920.4 4951.0 4960.1 4972.6 5023.4 4595.1 4631.5 4631.6 4634.1 4641.6 5063.8 5113.0 5119.6 5123.2 5195.7 4923.8 4941.9 4942.5 4945.5 5009.8 4887.5 5014.2 5016.7 5021.3 5029.0 4908.5 4956.1 4963.8 4968.0 5031.2 4915.8 4932.7 4936.9 4959.0 5001.8 4094.7 4235.0 4247.0 4248.1 4307.6 3631.9 3638.3 3639.7 3726.8 3752.0 4173.6 4175.7 4176.7 4183.7 4211.9 4910.6 4923.3 4924.7 4929.1 4970.8 4135.2 4144.4 4179.7 4193.1 4198.0 4473.8 4489.9 4500.9 4534.8 4546.2 4675.1 4677.0 4680.9 4684.1 4743.1 4761.0 4937.3 4992.8 4996.8 5005.5 4664.9 4685.3 4690.2 4730.6 4741.5 4910.1 4928.1 4931.7 4934.4 4982.4 4877.1 4914.2 4970.2 4971.6 4996.0 4765.6 4778.5 4799.5 4842.5 4860.3 4798.4 4810.9 4825.7 4827.8 4869.8 4639.8 4715.7 4737.0 4796.2 4817.4 4892.8 4908.8 4911.1 4916.7 4952.7 4817.1 4818.7 4818.9 4863.4 4872.8 07:50:28 INFO - PROCESS | 19946 | 07:50:28 INFO - PROCESS | 19946 | [#1] ext.html Cycles:180 Average:43673.80 Median:35015.47 stddev:79211.61 (226.2%) stddev-sans-first:79367.71 07:50:28 INFO - PROCESS | 19946 | Values: 570.6 571.5 583.6 584.8 585.6 28591.0 38738.6 39751.8 39786.2 44363.8 40616.6 41026.0 41065.8 41093.0 41110.2 7659.6 7807.1 7813.9 7814.5 7817.8 7459.0 9698.3 9922.4 9932.2 10318.3 10130.5 10227.9 10228.1 10232.6 10241.0 9968.7 10010.6 10047.6 10053.7 10063.4 9778.1 9847.7 9848.9 9852.0 9856.6 36872.4 37138.8 37162.4 37212.3 37300.4 3013.7 3157.3 3399.5 3401.9 3734.4 28710.3 28879.6 28990.7 29110.0 30519.1 3347.4 3535.3 3541.0 3565.6 3599.0 183981.0 184102.0 185072.0 185354.0 186420.0 31108.4 51568.7 51784.7 51971.5 51998.2 31443.0 33196.7 33222.5 33257.8 33262.2 11486.4 11543.5 11550.2 11551.8 11562.8 9302.6 9604.0 9774.1 9783.1 9785.4 7794.0 7806.8 7893.5 7907.6 7917.7 3043.0 3072.5 3072.6 3075.4 3077.4 876.8 893.6 926.6 928.1 957.9 26460.9 27509.7 28354.7 28936.9 29029.4 904.8 907.4 943.6 946.7 1003.5 14875.9 14977.6 15074.5 15116.5 15417.2 380932.0 382411.0 383253.0 383607.0 385553.0 46990.8 47418.3 47609.0 47644.5 47663.8 1074.0 1145.5 1169.1 1181.5 1195.2 26541.9 27902.3 29082.9 29285.3 29461.4 40666.6 41160.4 41169.0 41179.2 41206.4 296499.0 298914.0 299029.0 299095.0 299670.0 24522.6 25348.1 25394.6 26471.7 26545.9 40687.6 40816.6 40873.4 41193.4 41588.0 34736.0 34765.3 34843.0 34988.5 35026.3 34769.8 35004.6 35277.8 35314.8 35355.8 34577.0 34751.8 35266.8 35391.6 35593.3 30912.4 32618.0 32751.0 32751.7 32825.8 24715.6 24734.1 25024.5 25303.9 25582.4 07:50:28 INFO - PROCESS | 19946 | 07:50:28 INFO - PROCESS | 19946 | [#2] jquery.html Cycles:180 Average:23784.65 Median:375251.50 stddev:61790.77 (16.5%) stddev-sans-first:61939.04 07:50:28 INFO - PROCESS | 19946 | Values: 342.9 368.5 373.7 373.8 387.2 12964.0 16301.6 16417.8 16860.8 17971.4 16699.0 16829.8 17416.9 17526.6 17537.8 4961.9 4968.9 5134.2 5161.5 5163.3 3745.6 4959.6 5040.3 5770.8 6074.6 6047.6 6054.2 6061.9 6062.8 6126.6 5911.8 5975.1 6008.6 6017.4 6030.3 5166.7 5338.7 5343.5 5352.5 5353.0 21131.7 21431.2 21468.1 21574.6 21652.4 1821.3 1832.8 1880.6 1986.4 2106.8 12829.7 13457.6 13551.0 13720.1 14204.7 1730.2 1732.9 1748.2 1757.3 1777.6 69294.7 69966.7 71187.6 72546.3 74383.6 9769.7 9790.1 10137.4 10189.7 10426.3 13925.3 13937.6 13943.4 13945.5 13957.4 7227.5 7241.7 7320.7 7575.7 7583.9 6916.1 6937.5 6984.0 7144.7 7173.2 6126.4 6316.0 6361.1 6381.0 6530.5 1791.3 1813.0 1823.6 1832.7 1837.5 824.9 842.2 861.5 909.1 928.1 16491.5 16849.3 17279.8 17789.3 17907.8 853.5 858.4 878.6 902.4 925.0 9784.4 10407.7 10422.3 10538.9 10583.2 368075.0 374526.0 375977.0 378015.0 378037.0 68874.3 69696.2 71203.3 71240.6 72235.0 938.6 989.6 998.3 1004.4 1009.3 15450.2 15896.1 15901.6 16056.4 16494.0 33463.3 33942.7 34069.5 35071.0 35740.1 42697.0 44400.6 45850.8 46160.3 46207.8 4677.5 6808.6 7465.5 7587.8 7878.6 12262.5 12499.0 12535.7 12554.9 12612.4 4788.3 6877.4 10384.5 10472.5 10858.1 4505.1 6975.4 9911.0 10552.5 11100.1 10793.4 10858.8 11231.9 11280.4 11285.8 7908.4 8083.8 8107.2 8145.6 8192.2 10660.4 10817.4 10836.1 11322.6 11428.1 07:50:28 INFO - PROCESS | 19946 | 07:50:28 INFO - PROCESS | 19946 | [#3] mootools.html Cycles:180 Average:5046.47 Median:5030.80 stddev:2882.80 (57.3%) stddev-sans-first:2876.87 07:50:28 INFO - PROCESS | 19946 | Values: 1264.7 1375.7 1388.6 1473.5 1642.2 7250.2 7447.6 7577.9 7802.0 7802.2 7628.2 7737.1 7746.3 7751.4 7756.7 1690.8 1986.5 2150.3 2174.7 2175.8 2180.6 2209.4 2211.8 2221.9 2226.2 2131.0 2148.2 2152.5 2158.5 2193.4 2012.9 2019.0 2022.2 2062.2 2145.8 2134.8 2140.1 2147.1 2148.7 2150.0 7839.6 7864.5 7881.4 7886.3 7888.2 4292.5 4419.8 4427.7 4430.6 4431.2 2844.6 2895.3 2984.7 2986.9 3003.0 891.8 944.8 960.6 962.3 967.4 10160.0 10239.9 10306.5 10329.8 10356.7 3766.9 3817.2 3994.2 4027.9 4068.4 8251.9 8264.3 8275.7 8284.0 8286.5 4334.5 4375.3 4381.5 4385.8 4385.8 3408.1 3920.3 4033.4 4034.8 4052.7 3222.3 3265.8 3359.2 3374.6 3386.2 1030.8 1032.7 1039.2 1047.1 1061.4 807.8 814.9 815.2 821.5 830.5 5026.9 5034.7 5085.5 5142.5 5275.1 393.2 395.9 398.7 398.8 399.1 3512.1 3545.3 3628.4 3702.9 4054.7 9691.1 9713.7 9826.3 9857.3 9875.2 9747.1 9754.5 9760.4 9778.1 9788.1 6874.8 7276.9 7446.7 7461.2 7471.4 5069.9 5187.8 5226.5 5375.7 5540.2 8710.3 8895.8 8997.6 9014.9 9060.5 9000.2 9034.7 9193.2 9198.2 9204.8 5848.7 6556.5 6660.5 6668.5 6670.4 7272.5 7341.7 7433.5 7610.1 7620.8 6719.7 6728.6 6782.9 6846.3 6895.1 6387.1 6428.6 6461.6 6625.5 6634.5 6211.6 6331.8 6335.4 6339.8 6345.3 4520.5 4653.8 4655.1 4660.1 4710.5 4507.2 4577.0 4669.7 4702.2 4831.0 07:50:28 INFO - PROCESS | 19946 | 07:50:28 INFO - PROCESS | 19946 | [#4] prototype.html Cycles:180 Average:4169.05 Median:4719.79 stddev:1192.21 (25.3%) stddev-sans-first:1159.45 07:50:28 INFO - PROCESS | 19946 | Values: 289.5 297.0 297.3 303.0 303.8 4673.9 4777.5 4790.0 4793.0 4805.5 4582.6 4685.8 4719.7 4719.9 4743.2 3782.0 3789.7 3792.1 3795.1 3819.8 3568.4 3592.0 3794.1 3819.9 3830.8 3763.5 3769.6 3771.2 3773.2 3778.9 3749.6 3776.9 3777.6 3784.9 3787.9 3341.8 3348.8 3354.9 3356.8 3384.8 4585.3 4631.4 4652.8 4656.6 4659.6 4287.8 4293.9 4307.0 4326.7 4337.2 4990.2 5025.6 5040.8 5045.2 5053.2 3586.0 3661.3 3673.2 3697.9 3704.8 5088.9 5093.6 5100.4 5124.9 5259.2 3685.4 3695.5 3696.4 3696.8 3706.4 3763.4 3779.4 3787.1 3804.6 3808.4 4098.0 4180.5 4199.0 4213.7 4216.5 4862.8 4875.4 4889.8 4913.9 4926.2 1247.4 1277.8 1279.9 1284.1 1320.3 860.1 876.8 888.9 916.0 917.8 4291.0 4295.4 4297.6 4297.6 4354.5 5095.9 5147.2 5148.8 5158.4 5171.1 4187.4 4396.6 4416.6 4438.2 4439.3 2751.1 2765.2 2767.7 2775.5 2779.5 4705.5 4849.5 4853.3 4863.2 4883.4 5241.9 5274.6 5289.9 5301.0 5310.5 4844.0 4848.3 4855.0 4858.3 4889.5 4926.1 5202.1 5212.5 5212.8 5236.2 5051.7 5063.2 5067.9 5079.9 5084.9 4802.3 4828.7 4842.4 4846.9 4855.0 3693.6 3726.7 3777.4 3780.8 3798.4 5117.1 5129.7 5131.4 5132.4 5137.2 4967.8 4975.5 4978.4 4993.2 5037.3 4807.9 5001.7 5011.9 5037.8 5055.4 4705.0 4815.9 4849.9 4879.8 4926.5 5047.1 5056.9 5060.3 5065.7 5077.1 5003.3 5005.8 5008.6 5020.6 5022.8 07:50:28 INFO - PROCESS | 19946 | 07:50:28 INFO - PROCESS | 19946 | [#5] yui.html Cycles:180 Average:17316.56 Median:516.22 stddev:24908.68 (4825.2%) stddev-sans-first:24946.93 07:50:28 INFO - PROCESS | 19946 | Values: 600.4 608.3 640.2 656.7 733.4 12255.3 13397.8 13579.5 13580.5 13586.0 13612.6 13684.7 13751.7 13752.5 13764.4 617.4 738.9 741.1 758.9 760.4 764.5 771.3 774.6 775.4 776.0 816.1 816.5 817.7 817.7 817.9 643.3 661.2 808.8 808.9 809.9 490.1 491.3 560.1 575.9 579.5 12407.3 12440.8 12453.1 12461.5 12464.9 12409.0 12575.3 12970.9 13089.3 13448.5 11472.3 11535.7 11598.2 11783.6 12201.5 3983.7 4038.3 4064.9 4075.0 4118.1 64728.0 64858.7 65095.0 65141.0 65951.0 9660.6 9829.7 10061.9 10271.0 10434.9 17581.6 19054.6 19202.5 19211.7 19253.6 6887.3 6903.5 6984.3 7034.2 7097.9 3666.0 3761.6 3762.8 3790.8 3880.3 2931.6 3075.0 3078.1 3078.7 3079.9 516.0 516.1 516.3 521.8 533.2 541.2 548.4 589.8 600.1 622.6 8103.4 8264.0 8331.5 8525.5 8542.9 496.9 527.3 533.3 545.4 574.0 3748.9 3790.6 3873.0 4006.3 4008.7 56149.4 95482.0 101653.0 104414.0 106055.5 52502.4 52562.2 52607.7 87434.0 89653.6 69445.7 77996.6 79795.0 80383.0 80421.2 7406.8 7696.5 7808.7 7838.4 7840.6 31822.6 45494.0 46248.5 46973.8 46983.5 63128.3 68724.3 69936.7 70107.3 73677.3 10010.0 10034.9 10063.8 10256.9 10303.4 11999.0 12104.8 12122.3 12353.3 13126.6 10157.9 10571.3 10602.8 10948.7 11068.1 10167.8 10226.9 10478.9 10671.8 10833.7 10237.6 10396.2 10530.0 10568.0 10867.0 8479.6 8736.8 8773.5 8997.2 9542.1 8006.4 8694.3 8722.6 8777.5 8791.6 07:50:28 INFO - PROCESS | 19946 | -------- Summary: end -------- 07:50:28 INFO - PROCESS | 19946 | 07:50:29 INFO - TEST-INFO | 19946: exit 0 07:50:29 INFO - TEST-OK | dromaeo_css | took 1120551ms 07:50:29 INFO - TEST-START | kraken 07:50:29 INFO - operating with platform_type : linux_ 07:50:29 INFO - Initialising browser for kraken test... 07:50:29 INFO - TEST-INFO | started process 20249 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdK2jQF/profile http://localhost:49363/getInfo.html) 07:50:34 INFO - PROCESS | 20249 | __metrics Screen width/height:1600/1200 07:50:34 INFO - PROCESS | 20249 | colorDepth:24 07:50:34 INFO - PROCESS | 20249 | Browser inner width/height: 1024/697 07:50:34 INFO - PROCESS | 20249 | __metrics 07:50:34 INFO - PROCESS | 20249 | 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" 07:50:34 INFO - PROCESS | 20249 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:50:36 INFO - TEST-INFO | 20249: exit 0 07:50:36 INFO - Browser initialized. 07:50:36 INFO - Running cycle 1/1 for kraken test... 07:50:36 INFO - TEST-INFO | started process 20330 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdK2jQF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:50:48 INFO - PROCESS | 20330 | RSS: Main: 181710848 07:50:48 INFO - PROCESS | 20330 | 07:50:51 INFO - PROCESS | 20330 | Cycle 1(1): loaded http://localhost:49363/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49363/tests/kraken/driver.html?testName=audio-beat-detection) 07:50:52 INFO - PROCESS | 20330 | RSS: Main: 243863552 07:50:52 INFO - PROCESS | 20330 | 07:50:54 INFO - PROCESS | 20330 | Cycle 1(1): loaded http://localhost:49363/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49363/tests/kraken/driver.html?testName=audio-dft) 07:50:55 INFO - PROCESS | 20330 | RSS: Main: 226181120 07:50:55 INFO - PROCESS | 20330 | 07:50:58 INFO - PROCESS | 20330 | Cycle 1(1): loaded http://localhost:49363/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49363/tests/kraken/driver.html?testName=audio-fft) 07:50:59 INFO - PROCESS | 20330 | RSS: Main: 304730112 07:50:59 INFO - PROCESS | 20330 | 07:51:01 INFO - PROCESS | 20330 | Cycle 1(1): loaded http://localhost:49363/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49363/tests/kraken/driver.html?testName=audio-oscillator) 07:51:01 INFO - PROCESS | 20330 | RSS: Main: 214913024 07:51:01 INFO - PROCESS | 20330 | 07:51:04 INFO - PROCESS | 20330 | Cycle 1(1): loaded http://localhost:49363/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49363/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:51:04 INFO - PROCESS | 20330 | RSS: Main: 216379392 07:51:04 INFO - PROCESS | 20330 | 07:51:07 INFO - PROCESS | 20330 | Cycle 1(1): loaded http://localhost:49363/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49363/tests/kraken/driver.html?testName=imaging-darkroom) 07:51:08 INFO - PROCESS | 20330 | RSS: Main: 253976576 07:51:08 INFO - PROCESS | 20330 | 07:51:12 INFO - PROCESS | 20330 | Cycle 1(1): loaded http://localhost:49363/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49363/tests/kraken/driver.html?testName=imaging-desaturate) 07:51:12 INFO - PROCESS | 20330 | RSS: Main: 253464576 07:51:12 INFO - PROCESS | 20330 | 07:51:15 INFO - PROCESS | 20330 | Cycle 1(1): loaded http://localhost:49363/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49363/tests/kraken/driver.html?testName=json-parse-financial) 07:51:16 INFO - PROCESS | 20330 | RSS: Main: 252612608 07:51:16 INFO - PROCESS | 20330 | 07:51:17 INFO - PROCESS | 20330 | Cycle 1(1): loaded http://localhost:49363/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49363/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:51:18 INFO - PROCESS | 20330 | RSS: Main: 215658496 07:51:18 INFO - PROCESS | 20330 | 07:51:20 INFO - PROCESS | 20330 | Cycle 1(1): loaded http://localhost:49363/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49363/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:51:21 INFO - PROCESS | 20330 | RSS: Main: 223531008 07:51:21 INFO - PROCESS | 20330 | 07:51:23 INFO - PROCESS | 20330 | Cycle 1(1): loaded http://localhost:49363/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49363/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:51:24 INFO - PROCESS | 20330 | RSS: Main: 224473088 07:51:24 INFO - PROCESS | 20330 | 07:51:26 INFO - PROCESS | 20330 | Cycle 1(1): loaded http://localhost:49363/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49363/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:51:27 INFO - PROCESS | 20330 | RSS: Main: 218841088 07:51:27 INFO - PROCESS | 20330 | 07:51:30 INFO - PROCESS | 20330 | Cycle 1(1): loaded http://localhost:49363/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49363/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:51:30 INFO - PROCESS | 20330 | RSS: Main: 222318592 07:51:30 INFO - PROCESS | 20330 | 07:51:32 INFO - PROCESS | 20330 | Cycle 1(1): loaded http://localhost:49363/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49363/tests/kraken/driver.html?testName=ai-astar) 07:51:33 INFO - PROCESS | 20330 | RSS: Main: 273326080 07:51:33 INFO - PROCESS | 20330 | 07:51:33 INFO - PROCESS | 20330 | __start_tp_report 07:51:33 INFO - PROCESS | 20330 | _x_x_mozilla_page_load 07:51:33 INFO - PROCESS | 20330 | _x_x_mozilla_page_load_details 07:51:33 INFO - PROCESS | 20330 | |i|pagename|runs| 07:51:33 INFO - PROCESS | 20330 | |0;ai-astar;113;114;129;113;114;114;116;114;116;114 07:51:33 INFO - PROCESS | 20330 | |1;audio-beat-detection;149;127;149;182;124;150;147;122;182;121 07:51:33 INFO - PROCESS | 20330 | |2;audio-dft;161;162;163;161;162;161;163;161;161;163 07:51:33 INFO - PROCESS | 20330 | |3;audio-fft;75;76;77;167;79;79;76;78;164;76 07:51:33 INFO - PROCESS | 20330 | |4;audio-oscillator;87;86;149;86;86;86;147;86;88;154 07:51:33 INFO - PROCESS | 20330 | |5;imaging-gaussian-blur;118;117;118;118;118;118;117;119;120;118 07:51:33 INFO - PROCESS | 20330 | |6;imaging-darkroom;146;147;146;147;146;146;146;146;146;147 07:51:33 INFO - PROCESS | 20330 | |7;imaging-desaturate;96;95;95;95;95;96;95;95;95;95 07:51:33 INFO - PROCESS | 20330 | |8;json-parse-financial;67;67;68;66;68;69;67;68;67;67 07:51:33 INFO - PROCESS | 20330 | |9;json-stringify-tinderbox;65;66;66;67;66;65;65;66;66;66 07:51:33 INFO - PROCESS | 20330 | |10;stanford-crypto-aes;88;82;82;91;86;82;82;82;81;82 07:51:33 INFO - PROCESS | 20330 | |11;stanford-crypto-ccm;136;133;135;134;133;132;147;132;158;137 07:51:33 INFO - PROCESS | 20330 | |12;stanford-crypto-pbkdf2;174;174;172;176;179;173;174;175;177;179 07:51:33 INFO - PROCESS | 20330 | |13;stanford-crypto-sha256-iterative;69;73;74;73;67;68;67;68;66;69 07:51:33 INFO - PROCESS | 20330 | __end_tp_report 07:51:33 INFO - PROCESS | 20330 | __start_cc_report 07:51:33 INFO - PROCESS | 20330 | _x_x_mozilla_cycle_collect,1999 07:51:33 INFO - PROCESS | 20330 | __end_cc_report 07:51:33 INFO - PROCESS | 20330 | __startTimestamp1472050293035__endTimestamp 07:51:33 INFO - PROCESS | 20330 | 07:51:33 INFO - PROCESS | 20330 | ------- Summary: start ------- 07:51:33 INFO - PROCESS | 20330 | Number of tests: 14 07:51:33 INFO - PROCESS | 20330 | 07:51:33 INFO - PROCESS | 20330 | [#0] ai-astar Cycles:10 Average:115.70 Median:114.00 stddev:4.79 (4.2%) stddev-sans-first:4.97 07:51:33 INFO - PROCESS | 20330 | Values: 113.0 114.0 129.0 113.0 114.0 114.0 116.0 114.0 116.0 114.0 07:51:33 INFO - PROCESS | 20330 | 07:51:33 INFO - PROCESS | 20330 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:149.00 stddev:22.77 (15.3%) stddev-sans-first:24.12 07:51:33 INFO - PROCESS | 20330 | Values: 149.0 127.0 149.0 182.0 124.0 150.0 147.0 122.0 182.0 121.0 07:51:33 INFO - PROCESS | 20330 | 07:51:33 INFO - PROCESS | 20330 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 07:51:33 INFO - PROCESS | 20330 | Values: 161.0 162.0 163.0 161.0 162.0 161.0 163.0 161.0 161.0 163.0 07:51:33 INFO - PROCESS | 20330 | 07:51:33 INFO - PROCESS | 20330 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.50 stddev:37.35 (48.8%) stddev-sans-first:38.92 07:51:33 INFO - PROCESS | 20330 | Values: 75.0 76.0 77.0 167.0 79.0 79.0 76.0 78.0 164.0 76.0 07:51:33 INFO - PROCESS | 20330 | 07:51:33 INFO - PROCESS | 20330 | [#4] audio-oscillator Cycles:10 Average:105.50 Median:86.00 stddev:30.76 (35.8%) stddev-sans-first:31.89 07:51:33 INFO - PROCESS | 20330 | Values: 87.0 86.0 149.0 86.0 86.0 86.0 147.0 86.0 88.0 154.0 07:51:33 INFO - PROCESS | 20330 | 07:51:33 INFO - PROCESS | 20330 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 07:51:33 INFO - PROCESS | 20330 | Values: 118.0 117.0 118.0 118.0 118.0 118.0 117.0 119.0 120.0 118.0 07:51:33 INFO - PROCESS | 20330 | 07:51:33 INFO - PROCESS | 20330 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 07:51:33 INFO - PROCESS | 20330 | Values: 146.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 07:51:33 INFO - PROCESS | 20330 | 07:51:33 INFO - PROCESS | 20330 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 07:51:33 INFO - PROCESS | 20330 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 07:51:33 INFO - PROCESS | 20330 | 07:51:33 INFO - PROCESS | 20330 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:67.50 stddev:0.84 (1.2%) stddev-sans-first:0.88 07:51:33 INFO - PROCESS | 20330 | Values: 67.0 67.0 68.0 66.0 68.0 69.0 67.0 68.0 67.0 67.0 07:51:33 INFO - PROCESS | 20330 | 07:51:33 INFO - PROCESS | 20330 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 07:51:33 INFO - PROCESS | 20330 | Values: 65.0 66.0 66.0 67.0 66.0 65.0 65.0 66.0 66.0 66.0 07:51:33 INFO - PROCESS | 20330 | 07:51:33 INFO - PROCESS | 20330 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:82.00 stddev:3.36 (4.1%) stddev-sans-first:3.20 07:51:33 INFO - PROCESS | 20330 | Values: 88.0 82.0 82.0 91.0 86.0 82.0 82.0 82.0 81.0 82.0 07:51:33 INFO - PROCESS | 20330 | 07:51:33 INFO - PROCESS | 20330 | [#11] stanford-crypto-ccm Cycles:10 Average:137.70 Median:135.50 stddev:8.38 (6.2%) stddev-sans-first:8.87 07:51:33 INFO - PROCESS | 20330 | Values: 136.0 133.0 135.0 134.0 133.0 132.0 147.0 132.0 158.0 137.0 07:51:33 INFO - PROCESS | 20330 | 07:51:33 INFO - PROCESS | 20330 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:175.50 stddev:2.41 (1.4%) stddev-sans-first:2.51 07:51:33 INFO - PROCESS | 20330 | Values: 174.0 174.0 172.0 176.0 179.0 173.0 174.0 175.0 177.0 179.0 07:51:33 INFO - PROCESS | 20330 | 07:51:33 INFO - PROCESS | 20330 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.00 stddev:2.88 (4.2%) stddev-sans-first:3.05 07:51:33 INFO - PROCESS | 20330 | Values: 69.0 73.0 74.0 73.0 67.0 68.0 67.0 68.0 66.0 69.0 07:51:33 INFO - PROCESS | 20330 | -------- Summary: end -------- 07:51:33 INFO - PROCESS | 20330 | 07:51:34 INFO - TEST-INFO | 20330: exit 0 07:51:34 INFO - TEST-OK | kraken | took 64427ms 07:51:34 INFO - SUITE-END | took 1184s 07:51:34 INFO - Completed test suite (00:19:45) 07:51:34 INFO - javascript benchmark 07:51:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2495.15164843953, 2509.7615726505983, 2526.3431507807963, 2544.1095616534217, 2554.540182767101, 4521.276595744682, 4577.427821522309, 4579.908401831962, 4605.194091034068, 4614.930776038362, 4626.282926146444, 4637.698549594283, 4687.554682305184, 4699.85900422987, 4700.459447163577, 4224.61978421942, 4262.488501379838, 4287.421198138242, 4341.175176716414, 4409.955900441003, 4309.892252693692, 4361.563843615629, 4372.3878656988045, 4406.118776244748, 4432.180046691373, 4173.979130104361, 4227.070044590185, 4264.57354264571, 4279.764612946318, 4309.052008558112, 4261.275583150872, 4273.551277115889, 4378.715383500063, 4385.342198670193, 4397.0, 4296.334068219431, 4321.135772845412, 4322.286822674255, 4364.367166760802, 4367.213901497729, 4568.794404251817, 4688.484266730657, 4723.937114149289, 4727.196376615949, 4730.810767569293, 4877.439094504142, 4932.358793356877, 4942.258661200813, 4944.159492886218, 4946.703197808143, 4920.40955085392, 4951.009798040406, 4960.082384758795, 4972.627052971042, 5023.397192336906, 4595.080983803253, 4631.513691062457, 4631.6294696424875, 4634.096351211481, 4641.628669706415, 5063.822766203165, 5113.0285245803925, 5119.6160287978555, 5123.180291153398, 5195.7142357170715, 4923.753812309442, 4941.925871111936, 4942.456329803718, 4945.4807245238735, 5009.799608015712, 4887.535684110004, 5014.222795466709, 5016.698998060128, 5021.322121513549, 5028.974855125774, 4908.509149085135, 4956.058348913695, 4963.751812409365, 4968.00639872027, 5031.245313203049, 4915.827946021872, 4932.704037757746, 4936.851894443173, 4959.0, 5001.8499445016705, 4094.651954583834, 4235.02594403289, 4246.957530424718, 4248.065425606362, 4307.590778876001, 3631.94552081719, 3638.290533346025, 3639.727020473475, 3726.7950262735267, 3752.0432289765936, 4173.561776013536, 4175.749455032707, 4176.686748493875, 4183.686223533247, 4211.894702632459, 4910.558049775537, 4923.335349727812, 4924.655274130848, 4929.0881186979805, 4970.801167953314, 4135.214309281227, 4144.3990621360335, 4179.707420480598, 4193.119444916601, 4197.958020419818, 4473.821047158142, 4489.865304040884, 4500.887477813081, 4534.795934182904, 4546.181687296253, 4675.08835777027, 4677.0, 4680.92978605328, 4684.0866031123605, 4743.075100355398, 4761.0, 4937.308776771327, 4992.800287988585, 4996.750162491788, 5005.499450054966, 4664.906701866012, 4685.320628508915, 4690.249560070372, 4730.597899178609, 4741.525847415231, 4910.091633047898, 4928.088303663833, 4931.728754918514, 4934.383202099738, 4982.427020892644, 4877.146499362669, 4914.164592019437, 4970.204767237225, 4971.552560269593, 4996.0, 4765.642576806684, 4778.522147785194, 4799.544043315879, 4842.539958703917, 4860.270959356125, 4798.352222449925, 4810.927836082532, 4825.662203645851, 4827.806887724451, 4869.756512174448, 4639.814407423665, 4715.740634265148, 4737.0, 4796.184648609675, 4817.421909370898, 4892.828750993698, 4908.754562271801, 4911.091448082117, 4916.70499770015, 4952.653314267966, 4817.13291607514, 4818.68678535894, 4818.927716084191, 4863.392075990501, 4872.805087796449], "value": 4562.019697879735, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.603430615722, 571.4542611805726, 583.6060659055137, 584.780707234787, 585.5754577930999, 28591.0, 38738.612613873855, 39751.801240993824, 39786.20427591447, 44363.778181109046, 40616.59383406165, 41026.0, 41065.79467102668, 41092.99999999993, 41110.17779644413, 7659.57872317021, 7807.063152421689, 7813.882791758099, 7814.53112813233, 7817.843643127134, 7458.962705186466, 9698.321117521777, 9922.355046921963, 9932.155766759834, 10318.329308594955, 10130.544125514332, 10227.874933757317, 10228.079472847443, 10232.590696372174, 10241.0, 9968.700938971842, 10010.649627263083, 10047.648332308407, 10053.69838904834, 10063.396196228177, 9778.119969202735, 9847.655332063416, 9848.852267215998, 9851.950740246324, 9856.556454959473, 36872.44691329632, 37138.814305928565, 37162.44256336157, 37212.25575488475, 37300.44049339235, 3013.7136971987625, 3157.258044359574, 3399.5410619566287, 3401.897943061712, 3734.3942104894886, 28710.282242943886, 28879.566806497918, 28990.71009289901, 29110.0, 30519.084427467213, 3347.397468455677, 3535.275268569963, 3540.964590354089, 3565.5721313442295, 3598.964010359889, 183981.0, 184102.0, 185072.0, 185354.0, 186419.99999999863, 31108.377832443224, 51568.74215628898, 51784.74107629513, 51971.48028519667, 51998.22002669963, 31443.0, 33196.66803331984, 33222.50166247508, 33257.83371083129, 33262.16844578905, 11486.42567871603, 11543.538258469735, 11550.249233799776, 11551.826722599168, 11562.76874462506, 9302.627894884265, 9604.03959604034, 9774.12032917041, 9783.119519243302, 9785.36395134314, 7794.0, 7806.804829879298, 7893.486923349964, 7907.604619768988, 7917.722879699183, 3042.9543556846666, 3072.4623190941497, 3072.63128424586, 3075.384923015406, 3077.353755711326, 876.8071024374627, 893.6380765789866, 926.5737760630051, 928.1414691410419, 957.913787759105, 26460.867695661782, 27509.724902751117, 28354.736274490275, 28936.855315723707, 29029.41941161165, 904.8326059678981, 907.3829795738961, 943.6272672294406, 946.6781294359951, 1003.4982508745627, 14875.925620372045, 14977.625559360886, 15074.472393466176, 15116.470923517623, 15417.229138543027, 380932.0, 382411.0, 383253.0, 383607.0, 385553.0, 46990.76504617455, 47418.28872566914, 47609.0, 47644.52355476401, 47663.76168119137, 1073.9892601074046, 1145.5017067575632, 1169.1348402182493, 1181.527389044389, 1195.235049568277, 26541.867290663424, 27902.3024424391, 29082.854585726935, 29285.26786830261, 29461.433477810973, 40666.59333406628, 41160.38259426051, 41169.0, 41179.1764164709, 41206.38190427206, 296499.0, 298914.0, 299029.0, 299095.0, 299670.0, 24522.632160517962, 25348.11281605135, 25394.619080714172, 26471.73528264693, 26545.867270663523, 40687.593124069565, 40816.59183408128, 40873.38689919594, 41193.38209926793, 41588.0, 34736.0, 34765.30469390649, 34843.0, 34988.47517287294, 35026.299474009866, 34769.826150869085, 35004.64995350116, 35277.82361088178, 35314.82342588271, 35355.82322088476, 34577.0, 34751.82624086965, 35266.82366588151, 35391.646083538835, 35593.288134237686, 30912.381752364377, 32618.0, 32751.0, 32751.672483274862, 32825.83587082049, 24715.62926556067, 24734.134305299227, 25024.49951001006, 25303.87348063248, 25582.360440989123], "value": 16491.07271549106, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.8804951832266, 368.5135620980307, 373.7141087068393, 373.77013136920795, 387.1888393814958, 12964.0, 16301.592460188502, 16417.835821641795, 16860.83139168608, 17971.371002014934, 16699.0, 16829.83170168298, 17416.912915435438, 17526.64946701065, 17537.824621753778, 4961.925571116436, 4968.900621987558, 5134.229865520165, 5161.458046905059, 5163.277141200216, 3745.587985321626, 4959.578435832958, 5040.294358789773, 5770.798022069229, 6074.605150665215, 6047.576669633106, 6054.182685337489, 6061.939380606182, 6062.787802426916, 6126.571140020201, 5911.763529458816, 5975.073863551135, 6008.639481631072, 6017.428344307284, 6030.306514750816, 5166.664166829144, 5338.706371149585, 5343.519083282523, 5352.491513306269, 5353.0, 21131.683024754642, 21431.24990625336, 21468.141274349007, 21574.568508629898, 21652.35042948714, 1821.298799962011, 1832.8075552066973, 1880.64267789121, 1986.4040787763613, 2106.757722861875, 12829.743405131938, 13457.596272111852, 13551.0, 13720.108192967426, 14204.715905681931, 1730.1522254095528, 1732.896026238417, 1748.1521462090875, 1757.3234304792747, 1777.6000399910047, 69294.65352673204, 69966.65016674934, 71187.64406177988, 72546.27453725501, 74383.62808185979, 9769.706908792748, 9790.069943355513, 10137.391756494633, 10189.745256368502, 10426.270161088803, 13925.303734813422, 13937.58187254384, 13943.372548235353, 13945.511907083204, 13957.441702331793, 7227.457940654472, 7241.674124664402, 7320.67056982437, 7575.659095340613, 7583.886241706379, 6916.100906882073, 6937.54905931123, 6984.0, 7144.678489467987, 7173.246809085075, 6126.448619624255, 6315.968420157962, 6361.14124593174, 6380.968095159495, 6530.542861999709, 1791.3461586521087, 1812.9728054079199, 1823.6170404215263, 1832.688442964699, 1837.5130590393555, 824.8638974569249, 842.1957031035347, 861.5046348349724, 909.0909090909091, 928.132196396358, 16491.505254842374, 16849.32602695903, 17279.82720172782, 17789.288428462976, 17907.820921790615, 853.5262929074299, 858.403409630301, 878.6309749905055, 902.3999040637902, 925.0287198441744, 9784.364016339057, 10407.739806504898, 10422.270441069053, 10538.89461105379, 10583.153347732163, 368075.0, 374526.0, 375977.0, 378015.0, 378037.0, 68874.3112568878, 69696.24800293757, 71203.28796711967, 71240.64379678069, 72235.0, 938.6057855700623, 989.604158336671, 998.3161534348849, 1004.4174378860243, 1009.3187098708343, 15450.22748862575, 15896.125713085892, 15901.60245993813, 16056.43802466908, 16494.0, 33463.33073338471, 33942.66057339395, 34069.48895766516, 35071.0, 35740.10649733777, 42697.0, 44400.555994439645, 45850.77074614605, 46160.30759538677, 46207.76896115498, 4677.508861569486, 6808.62552559614, 7465.514741541782, 7587.772366829004, 7878.645460954156, 12262.509499619915, 12499.0, 12535.749285014432, 12554.937225313815, 12612.369381530703, 4788.281757736368, 6877.38103570661, 10384.532696028546, 10472.476376181008, 10858.13134949218, 4505.121501307213, 6975.40709039717, 9910.959349268223, 10552.525136369035, 11100.11199104086, 10793.352398856094, 10858.837117443403, 11231.943840280746, 11280.379579122899, 11285.774284514428, 7908.3673306136525, 8083.757487275391, 8107.175885425968, 8145.6334464950405, 8192.221738934792, 10660.413677247516, 10817.405042722727, 10836.13310935139, 11322.60370887015, 11428.085753139563], "value": 8379.933991421472, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1264.7027948432124, 1375.7248550289944, 1388.6320125166828, 1473.4990103364853, 1642.187117376898, 7250.238724933878, 7447.553146811195, 7577.924220757791, 7802.0, 7802.180771019046, 7628.160902300742, 7737.148913619511, 7746.302832745052, 7751.418643601738, 7756.728514501993, 1690.7632931389614, 1986.4835142862887, 2150.2796563151364, 2174.695542624034, 2175.7824217578273, 2180.5856887191385, 2209.4034610655194, 2211.8341124415733, 2221.8777967211795, 2226.220822712054, 2130.9893450532804, 2148.2051640892814, 2152.461884528868, 2158.5251244726137, 2193.385851961453, 2012.8792272463627, 2019.0207749241533, 2022.2012305139535, 2062.1957436599737, 2145.839062070351, 2134.7865213478685, 2140.1332460353583, 2147.1304121830526, 2148.7206663133693, 2149.967750483744, 7839.568823714693, 7864.4888082274465, 7881.369490440751, 7886.250806173404, 7888.211178882066, 4292.5063617683745, 4419.823207071746, 4427.667924905645, 4430.579094985971, 4431.246688063037, 2844.630198074237, 2895.319599894023, 2984.6567644720917, 2986.8506574671396, 3003.039027511197, 891.7681402835309, 944.759086432962, 960.582146766159, 962.2782912815388, 967.3663750243602, 10160.0, 10239.897601024044, 10306.536205870754, 10329.84505232422, 10356.689299320957, 3766.9434958475645, 3817.2365526894732, 3994.2211268802303, 4027.8993025174605, 4068.4100805383055, 8251.876221856677, 8264.256216940505, 8275.668973241123, 8283.958580207182, 8286.544240066854, 4334.501532323823, 4375.299952007664, 4381.539938306432, 4385.802638881258, 4385.824567017284, 3408.1309266137473, 3920.2747491714126, 4033.4151548025957, 4034.7579145250793, 4052.675785937118, 3222.2749881276527, 3265.804051756902, 3359.177001634615, 3374.6119196292248, 3386.205311185076, 1030.7989941961246, 1032.7279984035154, 1039.1738567838586, 1047.1256500821898, 1061.395004847245, 807.7657479330928, 814.9062857771314, 815.2173913043545, 821.4947807098591, 830.5058490198322, 5026.924596131061, 5034.6727462715535, 5085.474357692678, 5142.460041695643, 5275.103232450492, 393.2037623811804, 395.9109200429938, 398.6890225624018, 398.8105649816372, 399.1020204539785, 3512.0693016350688, 3545.3441113393587, 3628.38317486028, 3702.907857060752, 4054.6958978076173, 9691.12779849817, 9713.70858874235, 9826.263030272758, 9857.30998830075, 9875.160611347972, 9747.122758951728, 9754.512274386252, 9760.414375137372, 9778.119969202806, 9788.119069283799, 6874.759383421656, 7276.890846637305, 7446.73936412223, 7461.216572259943, 7471.364933980563, 5069.949300507095, 5187.792488300426, 5226.477352264743, 5375.704336261387, 5540.196671482532, 8710.346723995599, 8895.822083558163, 8997.550122493718, 9014.909850901407, 9060.456372617664, 9000.234980026771, 9034.683786067457, 9193.172614464731, 9198.172164505228, 9204.769880753034, 5848.707564621667, 6556.508261880474, 6660.500462465237, 6668.533202675766, 6670.433013193933, 7272.490925635367, 7341.6696248670005, 7433.479656423999, 7610.124835643972, 7620.771376858703, 6719.697613607302, 6728.596284222962, 6782.898256526255, 6846.281140480377, 6895.138107736533, 6387.137736405526, 6428.582142160744, 6461.644609546332, 6625.536212465081, 6634.535582509178, 6211.627302361872, 6331.810045698637, 6335.429811317003, 6339.841503962253, 6345.333739957238, 4520.525344838876, 4653.813847446064, 4655.1387993220005, 4660.067986402665, 4710.481846996896, 4507.1887060328145, 4577.0, 4669.673122881366, 4702.177119004092, 4830.951690483191], "value": 3971.7105831308727, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.5237334584608, 296.9896053638123, 297.31913917129776, 302.9954550681739, 303.80101033822825, 4673.929891051628, 4777.546133117357, 4789.976050119749, 4793.0, 4805.471398146201, 4582.633389328854, 4685.789139488723, 4719.65489835397, 4719.929201061978, 4743.193657078296, 3781.9621803781884, 3789.658930696237, 3792.146766977429, 3795.0891785971444, 3819.8281077351585, 3568.4290513517844, 3591.964080359189, 3794.146317078649, 3819.9045023874487, 3830.8276127574186, 3763.454299126625, 3769.604191559874, 3771.189828882138, 3773.2264885698505, 3778.8677396291137, 3749.568799588041, 3776.8866933992026, 3777.565579958285, 3784.867529636463, 3787.9431808522895, 3341.816200108993, 3348.7990720556845, 3354.9161270968175, 3356.781809182395, 3384.7799893006877, 4585.335126406652, 4631.3516107744945, 4652.767361631905, 4656.580907718288, 4659.603933665642, 4287.764172970486, 4293.935590966138, 4306.956930430687, 4326.697131200817, 4337.175936572041, 4990.226514890198, 5025.597952163818, 5040.823571175028, 5045.217991211368, 5053.216751403538, 3585.9959211420583, 3661.304352173105, 3673.2286219893854, 3697.8705745298785, 3704.8329776120436, 5088.872778180538, 5093.592512599021, 5100.404215028396, 5124.898146898435, 5259.158534634478, 3685.391910334765, 3695.519582454264, 3696.4270538066644, 3696.7597106188014, 3706.424769473017, 3763.3790424580184, 3779.3764028934916, 3787.1289603390824, 3804.562475315319, 3808.3906574947873, 4097.97951010243, 4180.519240287406, 4198.958010419918, 4213.662906967435, 4216.494020717533, 4862.78117484714, 4875.390576177978, 4889.755512224375, 4913.926291105637, 4926.162552366106, 1247.4137155536882, 1277.8435515858164, 1279.9168054076456, 1284.0947132271726, 1320.320035181882, 860.1140824950311, 876.7764220123828, 888.8711136885115, 915.9816803663889, 917.7934964632905, 4291.004682822502, 4295.37717031035, 4297.5702429756775, 4297.634701050383, 4354.499232588293, 5095.949040509621, 5147.176451767699, 5148.819791307286, 5158.432572417031, 5171.069207542679, 4187.371894215892, 4396.560343965578, 4416.624586910084, 4438.201123797748, 4439.334099884978, 2751.1333929812045, 2765.1566272287146, 2767.6955534891144, 2775.5004099261923, 2779.471290790098, 4705.505921878222, 4849.4908034656555, 4853.344798452164, 4863.221884498464, 4883.438404583448, 5241.895162096736, 5274.630775845654, 5289.894202115936, 5301.0, 5310.548603368757, 4843.951560484421, 4848.296996935424, 4854.975725121351, 4858.319835223072, 4889.535494128052, 4926.068988951568, 5202.1416466282635, 5212.478752124909, 5212.791488340576, 5236.214567814706, 5051.6716413433005, 5063.164577844762, 5067.87330316745, 5079.87300317495, 5084.872878178076, 4802.327674125555, 4828.744526423085, 4842.394700662418, 4846.878828029327, 4854.975725121351, 3693.6306369362846, 3726.6646001859963, 3777.3578491655935, 3780.8109594519615, 3798.4112462568346, 5117.130087884994, 5129.6665716729785, 5131.358580177478, 5132.384113906355, 5137.229415587692, 4967.801287948441, 4975.457608141488, 4978.352814134139, 4993.201087825931, 5037.269595908646, 4807.903841923212, 5001.674891132065, 5011.924821127613, 5037.773300201573, 5055.393352797688, 4704.976475117603, 4815.879603009953, 4849.903001940012, 4879.829205977774, 4926.458089610069, 5047.141985862486, 5056.8988620226655, 5060.291559181644, 5065.746712664279, 5077.060743762416, 5003.3495645565845, 5005.824796132263, 5008.599312055099, 5020.598352131748, 5022.824201152942], "value": 3792.218293956468, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.3696119074973, 608.2791891608443, 640.2317219336795, 656.7438698907426, 733.380293651864, 12255.325957072357, 13397.7990330145, 13579.456821727132, 13580.524681636145, 13586.0, 13612.591622251324, 13684.726305473909, 13751.724965500684, 13752.518661846838, 13764.449422023132, 617.3887851027496, 738.9261073892621, 741.0773586884336, 758.8861670749377, 760.3612965109307, 764.533634482965, 771.3250905457725, 774.6126936531734, 775.3603277296253, 776.0144616337249, 816.0615292413742, 816.5182542300042, 817.7015389382892, 817.7464985854374, 817.8650522663783, 643.2634633344841, 661.2329697550866, 808.7695006923028, 808.8544062068826, 809.8663720486113, 490.08843550995476, 491.32933545709847, 560.1457776890235, 575.91937128802, 579.5016285994042, 12407.25556466615, 12440.75118497625, 12453.128281020332, 12461.501539938483, 12464.875351246463, 12409.0, 12575.308358040304, 12970.87029129706, 13089.280089595068, 13448.529301474402, 11472.31166130035, 11535.711607209803, 11598.246114002563, 11783.64649060521, 12201.450934707871, 3983.661388781928, 4038.29329867275, 4064.8983775405554, 4075.0, 4118.094019315746, 64728.0, 64858.675706621165, 65095.0, 65141.0, 65951.0, 9660.565274562661, 9829.655962041294, 10061.949690251502, 10271.0, 10434.947825260977, 17581.648367032845, 19054.61890762177, 19202.51993700141, 19211.711824322647, 19253.61492770137, 6887.276835932155, 6903.5167538271835, 6984.3364880336285, 7034.2262351141335, 7097.858042839114, 3665.9633403666157, 3761.6426439488205, 3762.830672619739, 3790.8294126764363, 3880.2821478026653, 2931.6335458067742, 3074.9538756918664, 3078.122735020553, 3078.6921307869034, 3079.92300192497, 516.0, 516.1045585908446, 516.333929231295, 521.8434469659087, 533.2108479450358, 541.2071315522778, 548.4159370270648, 589.7935722497092, 600.1358044416027, 622.5828694774511, 8103.392245581605, 8263.95868020656, 8331.50010999342, 8525.488470691778, 8542.914570854336, 496.94036715593637, 527.3434573955374, 533.3120274845484, 545.3837164004728, 573.9713014349265, 3748.887533374003, 3790.566253045107, 3872.96127038726, 4006.338954072545, 4008.659263962596, 56149.43850561524, 95482.0, 101653.0, 104414.0, 106055.46972265089, 52502.44750354693, 52562.211566826525, 52607.73696131571, 87434.0, 89653.55173224091, 69445.65277173581, 77996.61001695068, 79795.0, 80383.0, 80421.19578804255, 7406.8148296290865, 7696.538207707556, 7808.6876524940635, 7838.412119091205, 7840.609258815081, 31822.635472905975, 45494.0, 46248.537514624426, 46973.76513117413, 46983.53016469791, 63128.265380095756, 68724.31275687179, 69936.65031674808, 70107.29892701212, 73677.26322736705, 10010.0, 10034.949825250827, 10063.849042264226, 10256.897431025594, 10303.3817970922, 11999.0, 12104.75790484203, 12122.27266364021, 12353.258804471761, 13126.556078831512, 10157.9492102539, 10571.2600117991, 10602.787944241227, 10948.726281843017, 11068.059214966817, 10167.847482287623, 10226.948865255627, 10478.947605261925, 10671.839922401015, 10833.729156770829, 10237.590496380062, 10396.16830653561, 10530.0, 10568.0, 10867.0, 8479.576021198793, 8736.78158046054, 8773.473591584525, 8997.235235005099, 9542.141207291377, 8006.359491240803, 8694.260987816106, 8722.607482663423, 8777.473351598925, 8791.648334066822], "value": 6407.370396900873, "unit": "score"}], "name": "dromaeo_css", "value": 6271.5441813355355, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 129.0, 113.0, 114.0, 114.0, 116.0, 114.0, 116.0, 114.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 127.0, 149.0, 182.0, 124.0, 150.0, 147.0, 122.0, 182.0, 121.0], "value": 145.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 161.0, 162.0, 161.0, 163.0, 161.0, 161.0, 163.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 167.0, 79.0, 79.0, 76.0, 78.0, 164.0, 76.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 149.0, 86.0, 86.0, 86.0, 147.0, 86.0, 88.0, 154.0], "value": 105.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 119.0, 120.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 66.0, 68.0, 69.0, 67.0, 68.0, 67.0, 67.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 67.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 82.0, 91.0, 86.0, 82.0, 82.0, 82.0, 81.0, 82.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 135.0, 134.0, 133.0, 132.0, 147.0, 132.0, 158.0, 137.0], "value": 137.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 172.0, 176.0, 179.0, 173.0, 174.0, 175.0, 177.0, 179.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 74.0, 73.0, 67.0, 68.0, 67.0, 68.0, 66.0, 69.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1582.0000000000002, "alertThreshold": 2.0}]} 07:51:34 INFO - Return code: 0 07:51:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:51:34 INFO - # TBPL SUCCESS # 07:51:34 INFO - Running post-action listener: _resource_record_post_action 07:51:34 INFO - [mozharness: 2016-08-24 14:51:34.832064Z] Finished run-tests step (success) 07:51:34 INFO - Running post-run listener: _resource_record_post_run 07:51:34 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406695936; Read time: 12; Write time: 246596 07:51:34 INFO - TinderboxPrint: CPU usage
13.0% 07:51:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:51:34 INFO - TinderboxPrint: I/O write bytes / time
406,695,936 / 246,596 07:51:34 INFO - TinderboxPrint: CPU idle
8,343.0 (87.0%) 07:51:34 INFO - TinderboxPrint: CPU user
1,199.2 (12.5%) 07:51:34 INFO - TinderboxPrint: Swap in / out
0 / 0 07:51:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114180096; Read time: 0; Write time: 102112 07:51:34 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 292515840; Read time: 0; Write time: 144484 07:51:35 INFO - Running post-run listener: _upload_blobber_files 07:51:35 INFO - Blob upload gear active. 07:51:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:51:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:51:35 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'] 07:51:35 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 07:51:35 INFO - (blobuploader) - INFO - Open directory for files ... 07:51:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:51:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:51:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:36 INFO - (blobuploader) - INFO - Done attempting. 07:51:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:51:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:51:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:41 INFO - (blobuploader) - INFO - Done attempting. 07:51:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:51:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:51:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:41 INFO - (blobuploader) - INFO - Done attempting. 07:51:41 INFO - (blobuploader) - INFO - Iteration through files over. 07:51:41 INFO - Return code: 0 07:51:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:51:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:51:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36e7ebd45eeee5dd1994d84f8d05f74da5061c27ec28d5ff8dcbc1377036b4d433d36d7211c72d59dccc865755d9b982b536e9295c8038794bb796cf9d148a6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9af77eb2e8eda8a38ff5d24457e52f91ca23368b877ccf7c1ec63dd08eee9e880474726ce9e3cb5b403283d2c2a3dce3c07338cf0f302b1d61822d3382a04a85", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8aa45fba9283491307dbc3b306df6ee5a4147c64d660d09ac5a7898dbeeddee407d5b6a6b7998f92d58ce083ae5e7c11ed7ba3e529290b2b941b4030a9401726"} 07:51:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:51:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:51:41 INFO - Contents: 07:51:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36e7ebd45eeee5dd1994d84f8d05f74da5061c27ec28d5ff8dcbc1377036b4d433d36d7211c72d59dccc865755d9b982b536e9295c8038794bb796cf9d148a6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9af77eb2e8eda8a38ff5d24457e52f91ca23368b877ccf7c1ec63dd08eee9e880474726ce9e3cb5b403283d2c2a3dce3c07338cf0f302b1d61822d3382a04a85", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8aa45fba9283491307dbc3b306df6ee5a4147c64d660d09ac5a7898dbeeddee407d5b6a6b7998f92d58ce083ae5e7c11ed7ba3e529290b2b941b4030a9401726"} 07:51:41 INFO - Running post-run listener: copy_logs_to_upload_dir 07:51:41 INFO - Copying logs to upload dir... 07:51:41 INFO - mkdir: /builds/slave/test/build/upload/logs 07:51:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.220118 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-24 07:51:41.502332) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 07:51:41.505485) ========= 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=232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943 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/36e7ebd45eeee5dd1994d84f8d05f74da5061c27ec28d5ff8dcbc1377036b4d433d36d7211c72d59dccc865755d9b982b536e9295c8038794bb796cf9d148a6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9af77eb2e8eda8a38ff5d24457e52f91ca23368b877ccf7c1ec63dd08eee9e880474726ce9e3cb5b403283d2c2a3dce3c07338cf0f302b1d61822d3382a04a85", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8aa45fba9283491307dbc3b306df6ee5a4147c64d660d09ac5a7898dbeeddee407d5b6a6b7998f92d58ce083ae5e7c11ed7ba3e529290b2b941b4030a9401726"} build_url:https://queue.taskcluster.net/v1/task/d5wwQyZeQJCS_wRcGIsNhQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011201 build_url: 'https://queue.taskcluster.net/v1/task/d5wwQyZeQJCS_wRcGIsNhQ/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/36e7ebd45eeee5dd1994d84f8d05f74da5061c27ec28d5ff8dcbc1377036b4d433d36d7211c72d59dccc865755d9b982b536e9295c8038794bb796cf9d148a6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9af77eb2e8eda8a38ff5d24457e52f91ca23368b877ccf7c1ec63dd08eee9e880474726ce9e3cb5b403283d2c2a3dce3c07338cf0f302b1d61822d3382a04a85", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8aa45fba9283491307dbc3b306df6ee5a4147c64d660d09ac5a7898dbeeddee407d5b6a6b7998f92d58ce083ae5e7c11ed7ba3e529290b2b941b4030a9401726"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 07:51:41.532451) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 07:51:41.532843) ========= 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=232498196343f89f466a4a9a000001c8-1472049054.912003-2111659943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 07:51:41.614798) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 07:51:41.615278) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 07:51:41.615653) ========= ========= Total master_lag: 0.16 =========