builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1485326431.5 results: success (0) buildid: 20170124193347 builduid: 4112813809f74e4caa2725cd22ceadc8 revision: 9c78f6d58ab9691a46f640ff3a81d7a55ad7a848 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 22:40:31.500892) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 22:40:31.501397) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 22:40:31.501731) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 22:40:31.513403) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 22:40:31.513718) ========= 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=6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-24 22:40:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 26.2M=0s 2017-01-24 22:40:32 (26.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113567 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 22:40:31.641420) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 22:40:31.642015) ========= 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=6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014296 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 22:40:31.692865) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 22:40:31.693258) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9c78f6d58ab9691a46f640ff3a81d7a55ad7a848 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9c78f6d58ab9691a46f640ff3a81d7a55ad7a848 --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=6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-24 22:40:32,179 truncating revision to first 12 chars 2017-01-24 22:40:32,180 Setting DEBUG logging. 2017-01-24 22:40:32,180 attempt 1/10 2017-01-24 22:40:32,180 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9c78f6d58ab9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-24 22:40:32,529 unpacking tar archive at: mozilla-beta-9c78f6d58ab9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.695402 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 22:40:32.402232) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 22:40:32.402550) ========= script_repo_revision: 9c78f6d58ab9691a46f640ff3a81d7a55ad7a848 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 22:40:32.403011) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 22:40:32.403274) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 22:40:32.412292) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-01-24 22:40:32.412572) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:40:32 INFO - MultiFileLogger online at 20170124 22:40:32 in /builds/slave/test 22:40:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 22:40:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:40:32 INFO - {'append_to_log': False, 22:40:32 INFO - 'base_work_dir': '/builds/slave/test', 22:40:32 INFO - 'blob_upload_branch': 'Mozilla-Beta', 22:40:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:40:32 INFO - 'branch': 'Mozilla-Beta', 22:40:32 INFO - 'buildbot_json_path': 'buildprops.json', 22:40:32 INFO - 'config_files': ('talos/linux_config.py',), 22:40:32 INFO - 'default_actions': ('clobber', 22:40:32 INFO - 'read-buildbot-config', 22:40:32 INFO - 'download-and-extract', 22:40:32 INFO - 'populate-webroot', 22:40:32 INFO - 'create-virtualenv', 22:40:32 INFO - 'install', 22:40:32 INFO - 'run-tests'), 22:40:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:40:32 INFO - 'download_minidump_stackwalk': True, 22:40:32 INFO - 'download_symbols': 'ondemand', 22:40:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:40:32 INFO - 'tooltool.py': '/tools/tooltool.py', 22:40:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:40:32 INFO - '/tools/misc-python/virtualenv.py')}, 22:40:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:40:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:40:32 INFO - 'installer_path': 'installer.exe', 22:40:32 INFO - 'log_level': 'info', 22:40:32 INFO - 'log_name': 'talos', 22:40:32 INFO - 'log_to_console': True, 22:40:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:40:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:40:32 INFO - 'opt_config_files': (), 22:40:32 INFO - 'pip_index': False, 22:40:32 INFO - 'sps_profile': False, 22:40:32 INFO - 'sps_profile_interval': 0, 22:40:32 INFO - 'suite': 'dromaeojs', 22:40:32 INFO - 'system_bits': '32', 22:40:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:40:32 INFO - 'title': 'talos-linux64-ix-050', 22:40:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:40:32 INFO - 'use_talos_json': True, 22:40:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:40:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:40:32 INFO - 'work_dir': 'build'} 22:40:32 INFO - [mozharness: 2017-01-25 06:40:32.997130Z] Running clobber step. 22:40:32 INFO - Running pre-action listener: _resource_record_pre_action 22:40:32 INFO - Running main action method: clobber 22:40:32 INFO - rmtree: /builds/slave/test/build 22:40:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:40:33 INFO - Running post-action listener: _resource_record_post_action 22:40:33 INFO - [mozharness: 2017-01-25 06:40:33.469241Z] Finished clobber step (success) 22:40:33 INFO - [mozharness: 2017-01-25 06:40:33.469343Z] Running read-buildbot-config step. 22:40:33 INFO - Running pre-action listener: _resource_record_pre_action 22:40:33 INFO - Running main action method: read_buildbot_config 22:40:33 INFO - Using buildbot properties: 22:40:33 INFO - { 22:40:33 INFO - "project": "", 22:40:33 INFO - "product": "firefox", 22:40:33 INFO - "script_repo_revision": "production", 22:40:33 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 22:40:33 INFO - "repository": "", 22:40:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 22:40:33 INFO - "buildid": "20170124193347", 22:40:33 INFO - "pgo_build": "True", 22:40:33 INFO - "basedir": "/builds/slave/test", 22:40:33 INFO - "buildnumber": 109, 22:40:33 INFO - "slavename": "talos-linux64-ix-050", 22:40:33 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:40:33 INFO - "platform": "ubuntu64_hw", 22:40:33 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 22:40:33 INFO - "branch": "mozilla-beta", 22:40:33 INFO - "repo_path": "releases/mozilla-beta", 22:40:33 INFO - "revision": "9c78f6d58ab9691a46f640ff3a81d7a55ad7a848", 22:40:33 INFO - "stage_platform": "linux64-pgo", 22:40:33 INFO - "builduid": "4112813809f74e4caa2725cd22ceadc8", 22:40:33 INFO - "slavebuilddir": "test" 22:40:33 INFO - } 22:40:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 22:40:33 INFO - Running post-action listener: _resource_record_post_action 22:40:33 INFO - [mozharness: 2017-01-25 06:40:33.471796Z] Finished read-buildbot-config step (success) 22:40:33 INFO - [mozharness: 2017-01-25 06:40:33.471886Z] Running download-and-extract step. 22:40:33 INFO - Running pre-action listener: _resource_record_pre_action 22:40:33 INFO - Running main action method: download_and_extract 22:40:33 INFO - mkdir: /builds/slave/test/build/tests 22:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:40:33 INFO - trying https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 22:40:33 INFO - Downloading https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 22:40:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:40:34 INFO - Downloaded 1327 bytes. 22:40:34 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 22:40:34 INFO - Using the following test package requirements: 22:40:34 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 22:40:34 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 22:40:34 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 22:40:34 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 22:40:34 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 22:40:34 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 22:40:34 INFO - u'jsshell-linux-x86_64.zip'], 22:40:34 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 22:40:34 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 22:40:34 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 22:40:34 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 22:40:34 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 22:40:34 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 22:40:34 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 22:40:34 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 22:40:34 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 22:40:34 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 22:40:34 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 22:40:34 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:40:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 22:40:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:40:34 INFO - Fetch https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 22:40:34 INFO - Http code: 200 22:40:34 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 22:40:34 INFO - x-amz-cf-id: arx_sFe7UnkGwVZQjFTTGLX_Duhrc3GrE40aGKV_Zgb5bUKwPwPZ_g== 22:40:34 INFO - x-amz-version-id: RUrHKFkYdl7fl0OKpzXDYqjiz4d1SUcM 22:40:34 INFO - Expected file size: 21953530 22:40:34 INFO - Obtained file size: 21953530 22:40:38 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:40:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 22:40:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:40:38 INFO - Fetch https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 22:40:39 INFO - Http code: 200 22:40:39 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 22:40:39 INFO - x-amz-cf-id: -hGAaZxjUDp3lsveUVNxKyMFD8d9TTLD8PK-9gSPabNTyZndtF2nMg== 22:40:39 INFO - x-amz-version-id: RUrHKFkYdl7fl0OKpzXDYqjiz4d1SUcM 22:40:39 INFO - Expected file size: 21953530 22:40:39 INFO - Obtained file size: 21953530 22:40:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 22:40:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:40:44 INFO - Fetch https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 22:40:44 INFO - Http code: 200 22:40:44 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 22:40:44 INFO - x-amz-cf-id: Hsxu0GpYv_fJZsZKKzLmt3SfTEfjysliv1SOWSFkRp7upAR6Ca1zKg== 22:40:44 INFO - x-amz-version-id: Y.UPnq85a3y4bn6WQpMza4vykdzpiSAQ 22:40:44 INFO - Expected file size: 14402992 22:40:44 INFO - Obtained file size: 14402992 22:40:45 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')]} 22:40:45 INFO - trying https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 22:40:45 INFO - Downloading https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 22:40:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:40:46 INFO - Downloaded 57653721 bytes. 22:40:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 22:40:46 INFO - mkdir: /builds/slave/test/properties 22:40:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:40:46 INFO - Writing to file /builds/slave/test/properties/build_url 22:40:46 INFO - Contents: 22:40:46 INFO - build_url:https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 22:40:46 INFO - Running post-action listener: _resource_record_post_action 22:40:46 INFO - Running post-action listener: set_extra_try_arguments 22:40:46 INFO - [mozharness: 2017-01-25 06:40:46.836120Z] Finished download-and-extract step (success) 22:40:46 INFO - [mozharness: 2017-01-25 06:40:46.836347Z] Running populate-webroot step. 22:40:46 INFO - Running pre-action listener: _resource_record_pre_action 22:40:46 INFO - Running main action method: populate_webroot 22:40:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:40:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:40:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:40:46 INFO - '--tppagecycles', 22:40:46 INFO - '7'], 22:40:46 INFO - 'tests': ['tsvgm']}}, 22:40:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:40:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:40:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:40:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:40:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:40:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:40:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:46 INFO - 'talos_options': ['--disable-e10s'], 22:40:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:40:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:40:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:46 INFO - 'talos_options': ['--disable-e10s'], 22:40:46 INFO - 'tests': ['damp', 'tps']}, 22:40:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:46 INFO - 'tests': ['damp', 'tps']}, 22:40:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:40:46 INFO - 'tests': ['dromaeo_dom']}, 22:40:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:40:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:40:46 INFO - 'tests': ['basic_compositor_video']}, 22:40:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:40:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:40:46 INFO - 'tests': ['a11yr', 22:40:46 INFO - 'ts_paint', 22:40:46 INFO - 'tpaint', 22:40:46 INFO - 'sessionrestore', 22:40:46 INFO - 'sessionrestore_no_auto_restore', 22:40:46 INFO - 'tabpaint']}, 22:40:46 INFO - 'other-e10s': {'tests': ['a11yr', 22:40:46 INFO - 'ts_paint', 22:40:46 INFO - 'tpaint', 22:40:46 INFO - 'sessionrestore', 22:40:46 INFO - 'sessionrestore_no_auto_restore', 22:40:46 INFO - 'tabpaint']}, 22:40:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:40:46 INFO - 'ts_paint', 22:40:46 INFO - 'tpaint', 22:40:46 INFO - 'sessionrestore', 22:40:46 INFO - 'sessionrestore_no_auto_restore', 22:40:46 INFO - 'tabpaint']}, 22:40:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:40:46 INFO - 'ts_paint', 22:40:46 INFO - 'tpaint', 22:40:46 INFO - 'sessionrestore', 22:40:46 INFO - 'sessionrestore_no_auto_restore', 22:40:46 INFO - 'tabpaint']}, 22:40:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:40:46 INFO - 'tests': ['a11yr', 22:40:46 INFO - 'ts_paint', 22:40:46 INFO - 'tpaint', 22:40:46 INFO - 'sessionrestore', 22:40:46 INFO - 'sessionrestore_no_auto_restore', 22:40:46 INFO - 'tabpaint']}, 22:40:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:40:46 INFO - 'tests': ['a11yr', 22:40:46 INFO - 'ts_paint', 22:40:46 INFO - 'tpaint', 22:40:46 INFO - 'sessionrestore', 22:40:46 INFO - 'sessionrestore_no_auto_restore', 22:40:46 INFO - 'tabpaint']}, 22:40:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:40:46 INFO - 'tests': ['tsvgx', 22:40:46 INFO - 'tsvgr_opacity', 22:40:46 INFO - 'tart', 22:40:46 INFO - 'tscrollx', 22:40:46 INFO - 'cart']}, 22:40:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:40:46 INFO - 'tsvgr_opacity', 22:40:46 INFO - 'tart', 22:40:46 INFO - 'tscrollx', 22:40:46 INFO - 'cart']}, 22:40:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:46 INFO - 'talos_options': ['--disable-e10s'], 22:40:46 INFO - 'tests': ['tp5o']}, 22:40:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:46 INFO - 'tests': ['tp5o']}, 22:40:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:46 INFO - 'talos_options': ['--disable-e10s', 22:40:46 INFO - '--xperf_path', 22:40:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:40:46 INFO - 'tests': ['tp5n']}, 22:40:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:46 INFO - 'talos_options': ['--xperf_path', 22:40:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:40:46 INFO - 'tests': ['tp5n']}}, 22:40:46 INFO - 'talos.zip': {'path': '', 22:40:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:40:46 INFO - Running post-action listener: _resource_record_post_action 22:40:46 INFO - [mozharness: 2017-01-25 06:40:46.855406Z] Finished populate-webroot step (success) 22:40:46 INFO - [mozharness: 2017-01-25 06:40:46.855494Z] Running create-virtualenv step. 22:40:46 INFO - Running pre-action listener: _resource_record_pre_action 22:40:46 INFO - Running main action method: create_virtualenv 22:40:46 INFO - Creating virtualenv /builds/slave/test/build/venv 22:40:46 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 22:40:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:40:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:40:46 INFO - Using real prefix '/usr' 22:40:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:40:47 INFO - Installing distribute.............................................................................................................................................................................................done. 22:40:49 INFO - Installing pip.................done. 22:40:49 INFO - Return code: 0 22:40:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:40:49 INFO - Reading from file tmpfile_stdout 22:40:49 INFO - Output received: 22:40:49 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 22:40:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:40: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')]} 22:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40: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')]} 22:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:49 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 0x7f37106a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e29ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e26f60>, '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 0x1e27d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e281d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425', '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 22:40:49 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 22:40:49 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 22:40:49 INFO - Using env: {'DISPLAY': ':0', 22:40:49 INFO - 'HOME': '/home/cltbld', 22:40:49 INFO - 'LANG': 'en_US.UTF-8', 22:40:49 INFO - 'LANGUAGE': 'en_US:en', 22:40:49 INFO - 'LOGNAME': 'cltbld', 22:40:49 INFO - 'MAIL': '/var/mail/cltbld', 22:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:49 INFO - 'MOZ_NO_REMOTE': '1', 22:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:49 INFO - 'NO_EM_RESTART': '1', 22:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:49 INFO - 'PWD': '/builds/slave/test', 22:40:49 INFO - 'SHELL': '/bin/bash', 22:40:49 INFO - 'SHLVL': '1', 22:40:49 INFO - 'TERM': 'linux', 22:40:49 INFO - 'TMOUT': '86400', 22:40:49 INFO - 'USER': 'cltbld', 22:40:49 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425', 22:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:49 INFO - '_': '/tools/buildbot/bin/python'} 22:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:49 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 22:40:49 INFO - Cleaning up... 22:40:49 INFO - Return code: 0 22:40:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:40: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')]} 22:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40: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')]} 22:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:49 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 0x7f37106a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e29ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e26f60>, '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 0x1e27d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e281d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425', '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 22:40:49 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 22:40:49 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 22:40:49 INFO - Using env: {'DISPLAY': ':0', 22:40:49 INFO - 'HOME': '/home/cltbld', 22:40:49 INFO - 'LANG': 'en_US.UTF-8', 22:40:49 INFO - 'LANGUAGE': 'en_US:en', 22:40:49 INFO - 'LOGNAME': 'cltbld', 22:40:49 INFO - 'MAIL': '/var/mail/cltbld', 22:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:49 INFO - 'MOZ_NO_REMOTE': '1', 22:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:49 INFO - 'NO_EM_RESTART': '1', 22:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:49 INFO - 'PWD': '/builds/slave/test', 22:40:49 INFO - 'SHELL': '/bin/bash', 22:40:49 INFO - 'SHLVL': '1', 22:40:49 INFO - 'TERM': 'linux', 22:40:49 INFO - 'TMOUT': '86400', 22:40:49 INFO - 'USER': 'cltbld', 22:40:49 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425', 22:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:49 INFO - '_': '/tools/buildbot/bin/python'} 22:40:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:50 INFO - Downloading/unpacking psutil>=3.1.1 22:40:50 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 22:40:50 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 22:40:50 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 22:40:50 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 22:40:50 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 22:40:50 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 22:40:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:40:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:40:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:40:52 INFO - Installing collected packages: psutil 22:40:52 INFO - Running setup.py install for psutil 22:40:52 INFO - building 'psutil._psutil_linux' extension 22:40:52 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 22:40:52 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 22:40:52 INFO - building 'psutil._psutil_posix' extension 22:40:52 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 22:40:52 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 22:40:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:40:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:40:52 INFO - Successfully installed psutil 22:40:52 INFO - Cleaning up... 22:40:52 INFO - Return code: 0 22:40:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:40:52 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')]} 22:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:52 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')]} 22:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:52 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 0x7f37106a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e29ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e26f60>, '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 0x1e27d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e281d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425', '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 22:40:52 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 22:40:52 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 22:40:52 INFO - Using env: {'DISPLAY': ':0', 22:40:52 INFO - 'HOME': '/home/cltbld', 22:40:52 INFO - 'LANG': 'en_US.UTF-8', 22:40:52 INFO - 'LANGUAGE': 'en_US:en', 22:40:52 INFO - 'LOGNAME': 'cltbld', 22:40:52 INFO - 'MAIL': '/var/mail/cltbld', 22:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:52 INFO - 'MOZ_NO_REMOTE': '1', 22:40:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:52 INFO - 'NO_EM_RESTART': '1', 22:40:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:52 INFO - 'PWD': '/builds/slave/test', 22:40:52 INFO - 'SHELL': '/bin/bash', 22:40:52 INFO - 'SHLVL': '1', 22:40:52 INFO - 'TERM': 'linux', 22:40:52 INFO - 'TMOUT': '86400', 22:40:52 INFO - 'USER': 'cltbld', 22:40:52 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425', 22:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:52 INFO - '_': '/tools/buildbot/bin/python'} 22:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:40:52 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 22:40:52 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 22:40:52 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 22:40:52 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 22:40:52 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 22:40:52 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 22:40:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:40:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:40:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:40:55 INFO - Installing collected packages: mozsystemmonitor 22:40:55 INFO - Running setup.py install for mozsystemmonitor 22:40:55 INFO - Successfully installed mozsystemmonitor 22:40:55 INFO - Cleaning up... 22:40:55 INFO - Return code: 0 22:40:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:40:55 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')]} 22:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:55 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')]} 22:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:55 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 0x7f37106a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e29ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e26f60>, '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 0x1e27d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e281d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425', '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 22:40:55 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 22:40:55 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 22:40:55 INFO - Using env: {'DISPLAY': ':0', 22:40:55 INFO - 'HOME': '/home/cltbld', 22:40:55 INFO - 'LANG': 'en_US.UTF-8', 22:40:55 INFO - 'LANGUAGE': 'en_US:en', 22:40:55 INFO - 'LOGNAME': 'cltbld', 22:40:55 INFO - 'MAIL': '/var/mail/cltbld', 22:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:55 INFO - 'MOZ_NO_REMOTE': '1', 22:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:55 INFO - 'NO_EM_RESTART': '1', 22:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:55 INFO - 'PWD': '/builds/slave/test', 22:40:55 INFO - 'SHELL': '/bin/bash', 22:40:55 INFO - 'SHLVL': '1', 22:40:55 INFO - 'TERM': 'linux', 22:40:55 INFO - 'TMOUT': '86400', 22:40:55 INFO - 'USER': 'cltbld', 22:40:55 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425', 22:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:55 INFO - '_': '/tools/buildbot/bin/python'} 22:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:55 INFO - Downloading/unpacking jsonschema==2.5.1 22:40:55 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 22:40:55 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 22:40:55 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 22:40:55 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 22:40:55 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 22:40:55 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 22:40:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:40:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:40:57 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 22:40:57 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 22:40:57 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 22:40:57 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 22:40:57 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 22:40:57 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 22:40:57 INFO - Downloading functools32-3.2.3-2.tar.gz 22:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:40:57 INFO - warning: no files found matching '*.txt' 22:40:57 INFO - no previously-included directories found matching 'build' 22:40:57 INFO - no previously-included directories found matching 'dist' 22:40:57 INFO - no previously-included directories found matching '.git*' 22:40:57 INFO - Installing collected packages: jsonschema, functools32 22:40:57 INFO - Running setup.py install for functools32 22:40:57 INFO - warning: no files found matching '*.txt' 22:40:57 INFO - no previously-included directories found matching 'build' 22:40:57 INFO - no previously-included directories found matching 'dist' 22:40:57 INFO - no previously-included directories found matching '.git*' 22:40:57 INFO - Successfully installed jsonschema functools32 22:40:57 INFO - Cleaning up... 22:40:57 INFO - Return code: 0 22:40:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:40: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')]} 22:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40: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')]} 22:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:57 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 0x7f37106a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e29ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e26f60>, '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 0x1e27d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e281d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425', '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 22:40:57 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 22:40:57 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 22:40:57 INFO - Using env: {'DISPLAY': ':0', 22:40:57 INFO - 'HOME': '/home/cltbld', 22:40:57 INFO - 'LANG': 'en_US.UTF-8', 22:40:57 INFO - 'LANGUAGE': 'en_US:en', 22:40:57 INFO - 'LOGNAME': 'cltbld', 22:40:57 INFO - 'MAIL': '/var/mail/cltbld', 22:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:57 INFO - 'MOZ_NO_REMOTE': '1', 22:40:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:57 INFO - 'NO_EM_RESTART': '1', 22:40:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:57 INFO - 'PWD': '/builds/slave/test', 22:40:57 INFO - 'SHELL': '/bin/bash', 22:40:57 INFO - 'SHLVL': '1', 22:40:57 INFO - 'TERM': 'linux', 22:40:57 INFO - 'TMOUT': '86400', 22:40:57 INFO - 'USER': 'cltbld', 22:40:57 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425', 22:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:57 INFO - '_': '/tools/buildbot/bin/python'} 22:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:40:58 INFO - Cleaning up... 22:40:58 INFO - Return code: 0 22:40:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:58 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 0x7f37106a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e29ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e26f60>, '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 0x1e27d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e281d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425', '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 22:40:58 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 22:40:58 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 22:40:58 INFO - Using env: {'DISPLAY': ':0', 22:40:58 INFO - 'HOME': '/home/cltbld', 22:40:58 INFO - 'LANG': 'en_US.UTF-8', 22:40:58 INFO - 'LANGUAGE': 'en_US:en', 22:40:58 INFO - 'LOGNAME': 'cltbld', 22:40:58 INFO - 'MAIL': '/var/mail/cltbld', 22:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:58 INFO - 'MOZ_NO_REMOTE': '1', 22:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:58 INFO - 'NO_EM_RESTART': '1', 22:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:58 INFO - 'PWD': '/builds/slave/test', 22:40:58 INFO - 'SHELL': '/bin/bash', 22:40:58 INFO - 'SHLVL': '1', 22:40:58 INFO - 'TERM': 'linux', 22:40:58 INFO - 'TMOUT': '86400', 22:40:58 INFO - 'USER': 'cltbld', 22:40:58 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425', 22:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:58 INFO - '_': '/tools/buildbot/bin/python'} 22:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:58 INFO - Downloading/unpacking blobuploader==1.2.4 22:40:58 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 22:40:58 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 22:40:58 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 22:40:58 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 22:40:58 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 22:40:58 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 22:41:00 INFO - Downloading blobuploader-1.2.4.tar.gz 22:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:41:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:41:00 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 22:41:00 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 22:41:00 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 22:41:00 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 22:41:00 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 22:41:00 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 22:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:41:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:41:00 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 22:41:00 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 22:41:00 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 22:41:00 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 22:41:00 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 22:41:00 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 22:41:01 INFO - Downloading docopt-0.6.1.tar.gz 22:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:41:01 INFO - Installing collected packages: blobuploader, requests, docopt 22:41:01 INFO - Running setup.py install for blobuploader 22:41:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:41:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:41:01 INFO - Running setup.py install for requests 22:41:01 INFO - Running setup.py install for docopt 22:41:01 INFO - Successfully installed blobuploader requests docopt 22:41:01 INFO - Cleaning up... 22:41:01 INFO - Return code: 0 22:41:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:41:01 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')]} 22:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:01 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')]} 22:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:01 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 0x7f37106a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e29ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e26f60>, '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 0x1e27d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e281d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425', '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 22:41:01 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 22:41:01 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 22:41:01 INFO - Using env: {'DISPLAY': ':0', 22:41:01 INFO - 'HOME': '/home/cltbld', 22:41:01 INFO - 'LANG': 'en_US.UTF-8', 22:41:01 INFO - 'LANGUAGE': 'en_US:en', 22:41:01 INFO - 'LOGNAME': 'cltbld', 22:41:01 INFO - 'MAIL': '/var/mail/cltbld', 22:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:01 INFO - 'MOZ_NO_REMOTE': '1', 22:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:01 INFO - 'NO_EM_RESTART': '1', 22:41:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:01 INFO - 'PWD': '/builds/slave/test', 22:41:01 INFO - 'SHELL': '/bin/bash', 22:41:01 INFO - 'SHLVL': '1', 22:41:01 INFO - 'TERM': 'linux', 22:41:01 INFO - 'TMOUT': '86400', 22:41:01 INFO - 'USER': 'cltbld', 22:41:01 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425', 22:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:01 INFO - '_': '/tools/buildbot/bin/python'} 22:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:41:01 INFO - Running setup.py (path:/tmp/pip-rglzmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:41:01 INFO - Running setup.py (path:/tmp/pip-fyiIF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:41:02 INFO - Running setup.py (path:/tmp/pip-aiw7hH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:41:02 INFO - Running setup.py (path:/tmp/pip-edBcPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:41:02 INFO - Running setup.py (path:/tmp/pip-jStsWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:41:02 INFO - Running setup.py (path:/tmp/pip-JVvwfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:41:02 INFO - Running setup.py (path:/tmp/pip-mNUiry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:41:02 INFO - Running setup.py (path:/tmp/pip-pLa5Np-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:41:02 INFO - Running setup.py (path:/tmp/pip-L58Xw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:41:02 INFO - Running setup.py (path:/tmp/pip-LJCzM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:41:02 INFO - Running setup.py (path:/tmp/pip-E3_TBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:41:02 INFO - Running setup.py (path:/tmp/pip-x6bhFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:41:02 INFO - Running setup.py (path:/tmp/pip-aLKq4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:41:02 INFO - Running setup.py (path:/tmp/pip-CafyBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:41:02 INFO - Running setup.py (path:/tmp/pip-kST7Wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:41:02 INFO - Running setup.py (path:/tmp/pip-uo_PTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:41:03 INFO - Running setup.py (path:/tmp/pip-qASP2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:41:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:41:03 INFO - Running setup.py install for manifestparser 22:41:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:41:03 INFO - Running setup.py install for mozcrash 22:41:03 INFO - Running setup.py install for mozdebug 22:41:03 INFO - Running setup.py install for mozdevice 22:41:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:41:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:41:03 INFO - Running setup.py install for mozfile 22:41:03 INFO - Running setup.py install for mozhttpd 22:41:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:41:03 INFO - Running setup.py install for mozinfo 22:41:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:41:03 INFO - Running setup.py install for mozInstall 22:41:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:41:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:41:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:41:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:41:03 INFO - Running setup.py install for mozleak 22:41:04 INFO - Running setup.py install for mozlog 22:41:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:41:04 INFO - Running setup.py install for moznetwork 22:41:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:41:04 INFO - Running setup.py install for mozprocess 22:41:04 INFO - Running setup.py install for mozprofile 22:41:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:41:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:41:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:41:04 INFO - Running setup.py install for mozrunner 22:41:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:41:04 INFO - Running setup.py install for mozscreenshot 22:41:04 INFO - Running setup.py install for moztest 22:41:04 INFO - Running setup.py install for mozversion 22:41:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:41:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:41:04 INFO - Cleaning up... 22:41:04 INFO - Return code: 0 22:41:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:41:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:04 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 0x7f37106a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e29ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e26f60>, '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 0x1e27d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e281d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425', '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 22:41:04 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 22:41:04 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 22:41:04 INFO - Using env: {'DISPLAY': ':0', 22:41:04 INFO - 'HOME': '/home/cltbld', 22:41:04 INFO - 'LANG': 'en_US.UTF-8', 22:41:04 INFO - 'LANGUAGE': 'en_US:en', 22:41:04 INFO - 'LOGNAME': 'cltbld', 22:41:04 INFO - 'MAIL': '/var/mail/cltbld', 22:41:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:04 INFO - 'MOZ_NO_REMOTE': '1', 22:41:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:04 INFO - 'NO_EM_RESTART': '1', 22:41:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:04 INFO - 'PWD': '/builds/slave/test', 22:41:04 INFO - 'SHELL': '/bin/bash', 22:41:04 INFO - 'SHLVL': '1', 22:41:04 INFO - 'TERM': 'linux', 22:41:04 INFO - 'TMOUT': '86400', 22:41:04 INFO - 'USER': 'cltbld', 22:41:04 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425', 22:41:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:04 INFO - '_': '/tools/buildbot/bin/python'} 22:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:41:05 INFO - Running setup.py (path:/tmp/pip-eQa4wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:41:05 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)) 22:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:41:05 INFO - Running setup.py (path:/tmp/pip-QU8Axp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:41:05 INFO - Running setup.py (path:/tmp/pip-1CIk1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:41:05 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)) 22:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:41:05 INFO - Running setup.py (path:/tmp/pip-bLWpDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:41:05 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)) 22:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:41:05 INFO - Running setup.py (path:/tmp/pip-CDhCq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:41:05 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)) 22:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:41:05 INFO - Running setup.py (path:/tmp/pip-yWlfVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:41:05 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)) 22:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:41:05 INFO - Running setup.py (path:/tmp/pip-WHyo0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:41:05 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)) 22:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:41:05 INFO - Running setup.py (path:/tmp/pip-uEQDBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:41:05 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)) 22:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:41:05 INFO - Running setup.py (path:/tmp/pip-JntdFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:41:05 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)) 22:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:41:05 INFO - Running setup.py (path:/tmp/pip-CJyL0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:41:05 INFO - Running setup.py (path:/tmp/pip-stNurl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:41:05 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)) 22:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:41:05 INFO - Running setup.py (path:/tmp/pip-FPeFW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:41:06 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)) 22:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:41:06 INFO - Running setup.py (path:/tmp/pip-8eXzT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:41:06 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)) 22:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:41:06 INFO - Running setup.py (path:/tmp/pip-cNZgYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:41:06 INFO - Running setup.py (path:/tmp/pip-q17lFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:41:06 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)) 22:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:41:06 INFO - Running setup.py (path:/tmp/pip-mBD6WG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:41:06 INFO - Running setup.py (path:/tmp/pip-oe6iED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:41:06 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)) 22:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:41:06 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)) 22:41:06 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)) 22:41:06 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)) 22:41:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:41:06 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 22:41:06 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 22:41:06 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 22:41:06 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 22:41:06 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 22:41:06 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 22:41:08 INFO - Downloading blessings-1.6.tar.gz 22:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:41:08 INFO - Installing collected packages: blessings 22:41:08 INFO - Running setup.py install for blessings 22:41:08 INFO - Successfully installed blessings 22:41:08 INFO - Cleaning up... 22:41:08 INFO - Return code: 0 22:41:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:41:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:41:08 INFO - Reading from file tmpfile_stdout 22:41:08 INFO - Current package versions: 22:41:08 INFO - argparse == 1.2.1 22:41:08 INFO - blessings == 1.6 22:41:08 INFO - blobuploader == 1.2.4 22:41:08 INFO - docopt == 0.6.1 22:41:08 INFO - functools32 == 3.2.3-2 22:41:08 INFO - jsonschema == 2.5.1 22:41:08 INFO - manifestparser == 1.1 22:41:08 INFO - mozInstall == 1.12 22:41:08 INFO - mozcrash == 1.0 22:41:08 INFO - mozdebug == 0.1 22:41:08 INFO - mozdevice == 0.48 22:41:08 INFO - mozfile == 1.2 22:41:08 INFO - mozhttpd == 0.7 22:41:08 INFO - mozinfo == 0.9 22:41:08 INFO - mozleak == 0.1 22:41:08 INFO - mozlog == 3.4 22:41:08 INFO - moznetwork == 0.27 22:41:08 INFO - mozprocess == 0.23 22:41:08 INFO - mozprofile == 0.28 22:41:08 INFO - mozrunner == 6.13 22:41:08 INFO - mozscreenshot == 0.1 22:41:08 INFO - mozsystemmonitor == 0.3 22:41:08 INFO - moztest == 0.8 22:41:08 INFO - mozversion == 1.4 22:41:08 INFO - psutil == 3.1.1 22:41:08 INFO - requests == 1.2.3 22:41:08 INFO - wsgiref == 0.1.2 22:41:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:41: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')]} 22:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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')]} 22:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:08 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 0x7f37106a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e29ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e26f60>, '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 0x1e27d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e281d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425', '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 22:41:08 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 22:41:08 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 22:41:08 INFO - Using env: {'DISPLAY': ':0', 22:41:08 INFO - 'HOME': '/home/cltbld', 22:41:08 INFO - 'LANG': 'en_US.UTF-8', 22:41:08 INFO - 'LANGUAGE': 'en_US:en', 22:41:08 INFO - 'LOGNAME': 'cltbld', 22:41:08 INFO - 'MAIL': '/var/mail/cltbld', 22:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:08 INFO - 'MOZ_NO_REMOTE': '1', 22:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:08 INFO - 'NO_EM_RESTART': '1', 22:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:08 INFO - 'PWD': '/builds/slave/test', 22:41:08 INFO - 'SHELL': '/bin/bash', 22:41:08 INFO - 'SHLVL': '1', 22:41:08 INFO - 'TERM': 'linux', 22:41:08 INFO - 'TMOUT': '86400', 22:41:08 INFO - 'USER': 'cltbld', 22:41:08 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425', 22:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:08 INFO - '_': '/tools/buildbot/bin/python'} 22:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:09 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)) 22:41:09 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)) 22:41:09 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)) 22:41:09 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)) 22:41:09 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)) 22:41:09 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)) 22:41:09 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)) 22:41:09 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)) 22:41:09 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)) 22:41:09 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)) 22:41:09 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)) 22:41:09 INFO - Cleaning up... 22:41:09 INFO - Return code: 0 22:41:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:41: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')]} 22:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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')]} 22:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:09 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 0x7f37106a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e29ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e26f60>, '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 0x1e27d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e281d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425', '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 22:41:09 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 22:41:09 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 22:41:09 INFO - Using env: {'DISPLAY': ':0', 22:41:09 INFO - 'HOME': '/home/cltbld', 22:41:09 INFO - 'LANG': 'en_US.UTF-8', 22:41:09 INFO - 'LANGUAGE': 'en_US:en', 22:41:09 INFO - 'LOGNAME': 'cltbld', 22:41:09 INFO - 'MAIL': '/var/mail/cltbld', 22:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:09 INFO - 'MOZ_NO_REMOTE': '1', 22:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:09 INFO - 'NO_EM_RESTART': '1', 22:41:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:09 INFO - 'PWD': '/builds/slave/test', 22:41:09 INFO - 'SHELL': '/bin/bash', 22:41:09 INFO - 'SHLVL': '1', 22:41:09 INFO - 'TERM': 'linux', 22:41:09 INFO - 'TMOUT': '86400', 22:41:09 INFO - 'USER': 'cltbld', 22:41:09 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425', 22:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:09 INFO - '_': '/tools/buildbot/bin/python'} 22:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:41:09 INFO - Cleaning up... 22:41:09 INFO - Return code: 0 22:41:09 INFO - Running post-action listener: _resource_record_post_action 22:41:09 INFO - Running post-action listener: _start_resource_monitoring 22:41:09 INFO - Starting resource monitoring. 22:41:09 INFO - [mozharness: 2017-01-25 06:41:09.377960Z] Finished create-virtualenv step (success) 22:41:09 INFO - [mozharness: 2017-01-25 06:41:09.378468Z] Running install step. 22:41:09 INFO - Running pre-action listener: _resource_record_pre_action 22:41:09 INFO - Running main action method: install 22:41:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:41:09 INFO - Reading from file tmpfile_stdout 22:41:09 INFO - Detecting whether we're running mozinstall >=1.0... 22:41:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:41:09 INFO - Reading from file tmpfile_stdout 22:41:09 INFO - Output received: 22:41:09 INFO - Usage: mozinstall [options] installer 22:41:09 INFO - Options: 22:41:09 INFO - -h, --help show this help message and exit 22:41:09 INFO - -d DEST, --destination=DEST 22:41:09 INFO - Directory to install application into. [default: 22:41:09 INFO - "/builds/slave/test"] 22:41:09 INFO - --app=APP Application being installed. [default: firefox] 22:41:09 INFO - mkdir: /builds/slave/test/build/application 22:41:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:41:23 INFO - Reading from file tmpfile_stdout 22:41:23 INFO - Output received: 22:41:23 INFO - /builds/slave/test/build/application/firefox/firefox 22:41:23 INFO - Running post-action listener: _resource_record_post_action 22:41:23 INFO - [mozharness: 2017-01-25 06:41:23.268818Z] Finished install step (success) 22:41:23 INFO - [mozharness: 2017-01-25 06:41:23.269062Z] Running run-tests step. 22:41:23 INFO - Running pre-action listener: _resource_record_pre_action 22:41:23 INFO - Running main action method: run_tests 22:41:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:41:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:41:23 INFO - Python 2.7.3 22:41:23 INFO - Return code: 0 22:41:23 INFO - grabbing minidump binary from tooltool 22:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:41:23 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 0x1e26f60>, '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 0x1e27d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e281d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:41:23 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 22:41:23 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 22:41:23 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 22:41:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:41:23 INFO - Return code: 0 22:41:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:41:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:41:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:41:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:41:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:41:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 22:41:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 22:41:23 INFO - Using env: {'DISPLAY': ':0', 22:41:23 INFO - 'HOME': '/home/cltbld', 22:41:23 INFO - 'LANG': 'en_US.UTF-8', 22:41:23 INFO - 'LANGUAGE': 'en_US:en', 22:41:23 INFO - 'LOGNAME': 'cltbld', 22:41:23 INFO - 'MAIL': '/var/mail/cltbld', 22:41:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:41:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:23 INFO - 'MOZ_NO_REMOTE': '1', 22:41:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:41:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:23 INFO - 'NO_EM_RESTART': '1', 22:41:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:23 INFO - 'PWD': '/builds/slave/test', 22:41:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:41:23 INFO - 'SHELL': '/bin/bash', 22:41:23 INFO - 'SHLVL': '1', 22:41:23 INFO - 'TERM': 'linux', 22:41:23 INFO - 'TMOUT': '86400', 22:41:23 INFO - 'USER': 'cltbld', 22:41:23 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425', 22:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:23 INFO - '_': '/tools/buildbot/bin/python'} 22:41:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 22:41:23 INFO - mozversion application_buildid: 20170124193347 22:41:23 INFO - mozversion application_changeset: 9c78f6d58ab9691a46f640ff3a81d7a55ad7a848 22:41:23 INFO - mozversion application_display_name: Firefox 22:41:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:41:23 INFO - mozversion application_name: Firefox 22:41:23 INFO - mozversion application_remotingname: firefox 22:41:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 22:41:23 INFO - mozversion application_vendor: Mozilla 22:41:23 INFO - mozversion application_version: 52.0 22:41:23 INFO - mozversion platform_buildid: 20170124193347 22:41:23 INFO - mozversion platform_changeset: 9c78f6d58ab9691a46f640ff3a81d7a55ad7a848 22:41:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 22:41:23 INFO - mozversion platform_version: 52.0 22:41:23 INFO - using testdate: 1485326483 22:41:23 INFO - actual date: 1485326483 22:41:23 INFO - starting webserver on 'localhost:52937' 22:41:23 INFO - SUITE-START | Running 2 tests 22:41:23 INFO - TEST-START | dromaeo_css 22:41:23 INFO - operating with platform_type : linux_ 22:41:23 INFO - Initialising browser for dromaeo_css test... 22:41:23 INFO - TEST-INFO | started process 8760 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUvpG8h/profile http://localhost:52937/getInfo.html) 22:41:27 INFO - PROCESS | 8760 | __metrics Screen width/height:1600/1200 22:41:27 INFO - PROCESS | 8760 | colorDepth:24 22:41:27 INFO - PROCESS | 8760 | Browser inner width/height: 1024/697 22:41:27 INFO - PROCESS | 8760 | __metrics 22:41:27 INFO - PROCESS | 8760 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:41:27 INFO - PROCESS | 8760 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:41:28 INFO - PROCESS | 8760 | console.error: PushService: 22:41:28 INFO - PROCESS | 8760 | stateChangeProcessEnqueue: Error transitioning state 22:41:28 INFO - PROCESS | 8760 | UnknownError 22:41:28 INFO - TEST-INFO | 8760: exit 0 22:41:28 INFO - Browser initialized. 22:41:28 INFO - Running cycle 1/1 for dromaeo_css test... 22:41:28 INFO - TEST-INFO | started process 8850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUvpG8h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:41:40 INFO - PROCESS | 8850 | RSS: Main: 141983744 22:41:40 INFO - PROCESS | 8850 | 22:44:41 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:52937/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52937/tests/dromaeo/cssquery-ext.html) 22:44:42 INFO - PROCESS | 8850 | RSS: Main: 239206400 22:44:42 INFO - PROCESS | 8850 | 22:47:44 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:52937/tests/dromaeo/cssquery-ext.html (next: http://localhost:52937/tests/dromaeo/cssquery-jquery.html) 22:47:45 INFO - PROCESS | 8850 | RSS: Main: 234209280 22:47:45 INFO - PROCESS | 8850 | 22:50:47 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:52937/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52937/tests/dromaeo/cssquery-mootools.html) 22:50:48 INFO - PROCESS | 8850 | RSS: Main: 174108672 22:50:48 INFO - PROCESS | 8850 | 22:53:50 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:52937/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52937/tests/dromaeo/cssquery-prototype.html) 22:53:50 INFO - PROCESS | 8850 | RSS: Main: 215535616 22:53:50 INFO - PROCESS | 8850 | 22:56:53 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:52937/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52937/tests/dromaeo/cssquery-yui.html) 22:56:53 INFO - PROCESS | 8850 | RSS: Main: 174870528 22:56:53 INFO - PROCESS | 8850 | 22:59:56 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:52937/tests/dromaeo/cssquery-yui.html (next: http://localhost:52937/tests/dromaeo/cssquery-dojo.html) 22:59:56 INFO - PROCESS | 8850 | RSS: Main: 259317760 22:59:56 INFO - PROCESS | 8850 | 22:59:56 INFO - PROCESS | 8850 | __start_tp_report 22:59:56 INFO - PROCESS | 8850 | _x_x_mozilla_page_load 22:59:56 INFO - PROCESS | 8850 | _x_x_mozilla_page_load_details 22:59:56 INFO - PROCESS | 8850 | |i|pagename|runs| 22:59:56 INFO - PROCESS | 8850 | |0;dojo.html;3168.255459966908;3184.4427225235577;3200.7919485233456;3222.7260682841957;3233.2401885556906;5407.945920540798;5475.534579560737;5505.3393592768825;5518.503334699876;5523.861903452405;5537.58468114892;5550.417206193352;5562.360328562217;5580.274564306635;5583.58123140764;4985.875353116183;4996;5027.798888044474;5054.747262636872;5073.619478539124;4945.282933974571;5018.447970723218;5086.033653605803;5088.465711100337;5119.308893299394;4908.680935739166;4975.029869175512;5000.949990500103;5019.071471777715;5032.798688052492;5031.421386540558;5067.239914012891;5067.695938243717;5108.029474399889;5118.744062796883;4931.65478416511;4990.001999600095;5011.198208286693;5016.673916195436;5030.245463180516;5320.388155362106;5352.384475785257;5367.114426119724;5421.620486565942;5424.945750542483;5722.54219662426;5736.168255602956;5748.5688573357165;5810.215620891167;5825.0679891217205;5855.882882342372;5863.5016023638045;5870.324912635059;5873.2658417697785;5884.411558844125;5456.454354564512;5501.724913754297;5507.008738427082;5533.03171944908;5610.410906854803;6043.214382130383;6058.424449677362;6060.727267272983;6067.362926892612;6070.757169713162;5813.186153938452;5814.709264536757;5822.912656310159;5832.591718579659;5834.154047663065;5734.655920644775;5778.393268706809;5811.099279611667;5901.262342207224;5912.23140991677;5902.1146827976145;5914.4381283777975;5933.58464907461;5944.762209511658;5960.105984102419;5883.676397798162;5938.2280303560265;5957.702114894238;5959.821205363846;5970.9701451492465;4507.323901414748;4508.752018638941;4537.296719008559;4547.431571053618;4624.930626040612;4075.612816782401;4075.735077219971;4077.561442706621;4090.6931980101613;4127.938080928789;5616;5620.775168993277;5638.182463542763;5646.689432081275;5647.548196144298;5655.349634791969;5687.829365119053;5881.823545293648;5896.7936122235515;5917.437843404869;5705.286839145107;5760.049591817387;5761.39505351932;5792.218050563204;5802.564807639444;5155.9742201288755;5156.226566015128;5156.458571849902;5156.639035267495;5179.896402071938;5836.649801011953;5932.911006334994;6264.37356264379;6267.968660156761;6280.937190628127;5835.328937172279;5840.357560668238;5863.706814659165;5935.0503919372695;5967.283925928743;6163.568550201443;6177.536684748752;6189.133521307111;6197.721102550306;6198.2871969722255;5605.943940560543;5751.683657398716;5801.94198058014;5812.360640329645;5812.709364531841;5660.51885589713;5718.428157184415;5729.856753581027;5753.683547404933;5836.970815145897;5591.524720398649;5597.356304025089;5631.352394474524;5632.070708333079;5644.689542075225;5613.607047506635;5619.100943848965;5620.775168993358;5623.212750215055;5628.155776633538;5502.862428439161;5520.282363292747;5676.460736230051;5710.2576665033275;5745.569082318759;5824.796132135524;5826.271716035496;5839.912401313899;5842.795502157574;5856.853578660568;5466.508014278734;5690;5693.060644993529;5693.3168019837885;5703.8859222816145 22:59:56 INFO - PROCESS | 8850 | |1;ext.html;591.2077815726925;612.9632222066675;648.3581254557986;657.6218674262298;659.9043138744885;34992;47017.29474057887;47966.76016619912;47995.5200447995;48051.51948480514;48708.2693759593;49165.50834491663;49179;49191.262131067975;49194.50805491944;8407.873881891777;9070.138336857988;9077.591508382106;9213.447193168398;9216.124468175512;8478.872816907751;10776.137908967303;11027.062699670538;11037.282576632533;11335.093192544618;11174.776504469906;11251.662450126509;11254.155938304619;11255.268407553524;11302.491387887565;11010.339379637207;11023.44882755863;11072.280301780358;11074.501647425885;11091.389973551451;10988;11065.557377704883;11066.502007409686;11074.390908500029;11075.889241107567;45013.32480012802;45304.54695453069;45317.32024019642;45334.77332613316;45385.09229815385;3699.463577781207;3798.0694729791376;3845.7692538447504;3951.249262640089;4156;34173.31653366919;34396.14009649754;34705;35859;36004.459933101025;4345.521992580813;4386.912261754779;4453.354263631788;4466.0844526871915;4602.493725690171;255550;259388;260356;261558;261967;65104.34895650983;65426.67286663631;65431.67284163644;65449.67275163594;65494.34505654978;41062;42057.57942420598;42070.57929420728;43758.34362484565;43896.78051609721;19374.8062519373;19576.412707618794;19580.314688985818;19591.412257632295;19616.70574941377;13676.384562694702;13789.655258618413;14055.086419382707;14909.850901491063;15183.089014659156;20470.38588842337;21421.357359279245;21499;21532.461688457915;21570.137194512045;7599.620018999028;7655.311022008046;7681.539107653447;7731.922680773233;7786.104597971193;1042.2964498963322;1043.5043354406596;1047.261680515235;1121.3336713239712;1133.3709791066037;33957.471913763446;34559.82720086434;34758.82620586881;34949.30101398009;35169;1131.7057565033151;1144.782491326662;1164.0687450039934;1167.1654766841748;1283.646997075793;18070.728939065924;18275.72586411205;18313.633727325647;18396.080195990413;18508.722369164472;519269;520361;520775;523292;525403;64020.67989660022;64043.6797816008;64203;64360.678196608715;64535.354646453874;1286.9163504372186;1353.6074538383955;1365.938532766028;1409.5348534983432;1453.077295917079;31406.214844628154;35736.821315894296;36183.81908090548;36268.27463450769;36296.81851590725;55439.16841247304;55753.72123139358;55815.44184558102;56087;56116.8776624457;380224;380902;381011;381637;381725;27770.305742356602;28632.284192894513;28654.283642909093;29253.70746292595;31528.842355788074;44778;49282.75358623184;50895.745521272154;51431.22853157131;52262.21606675979;43124.13751725011;43219.13561728685;43616;44360;45163;43360.566394336915;43541.10929201768;43637.78181109074;44889;45540.544594553634;43815.78092109519;43891.34162987622;45090.323645144694;45097;45251.77374113108;36682.8165859169;39151.044710512084;39166.608333916294;39289;39759.403608946464;29196.27009324699;29522;29589.408211836075;29714.554281686225;29752 22:59:56 INFO - PROCESS | 8850 | |2;jquery.html;393.5297319702956;394.20370850881204;410.3577900585584;410.8746832216174;423.5193055881575;14496.347664355102;18584.814151858478;20531;20556.69164962525;21638.567228655418;16672.916635416837;16868.49394518163;17860.374886878963;20589.073491692874;20607.484812879684;1937.2541571495005;1942.019280263465;1942.7280180774703;1943.1061711612674;2223.288547664744;5813.854653633672;5904.321003084658;5904.940950590482;5906.114082887559;5910.290765108171;4441.800118994637;4639.118567472169;6237.095621134933;6454.096426500294;6539.6730163491875;6424.967875160641;6605.471562275006;6636.369544893228;6637.900431493532;6641.335866413368;5865.941340586625;5868.178455016301;5871.295444546682;5871.471567558898;5903.704814759245;24543.877280613662;24729.752702473106;24763.87618061916;24787.25638230856;24982.625260621106;2769.0031588628076;2788.860556972143;3193.979348927289;3201;3254.007527704049;15068.849311506854;15081.170535620537;15518.844811551853;15519.456819011393;15579.143147126904;1972.80271972803;2041.7243672104373;2048.262625454835;2053.168466770945;2087.8642888212216;58698.70650646762;78111.609441953;83981.58009209915;88978.5551072247;90928.54535727279;10619.522121504551;10770.892291077145;11530.308181509135;11592.420378981018;11647.242929209575;16433.09617970999;16501.174941252888;16512.83487165137;16512.917435412746;16530.09084500364;8827.925437522177;8833.60248788806;9003.324750643596;9026.052264512264;9049.09509049103;8875.556222188865;8904.154105359981;8959.955200223958;9123.996360400351;9140.588673509708;6674.699638516278;7030.050943122613;7057.082579264663;7091.219965803757;7107.324804143598;1996.3212507747146;2025.2405347994502;2037.7758446570865;2048.2523878784436;2064.7109404683356;956.9856452153223;1022.9744256393501;1055.1295181475314;1072.554889720757;1083.101026148295;20369.694454583194;20893;20974.2659006934;21135.154593816384;21314.424280972326;1058.2486434631498;1068.6526878764278;1112.3214838948236;1123.7471568896933;1142.868570114431;10877.728056798644;11733.35466549348;12124.939375303067;12150.939245303716;12170.45232964501;455800;456928;457806;459190;478210;76765.6161719199;77289;96911;99459;99566.5021674887;1017.9491025448846;1067.3649178738483;1089.9727506812394;1093.1637297467444;1104.5747387255803;17807.287708492033;18145.364912228008;18479.53801154982;18653.656977644303;18834.434966951012;39742.205155897296;41619.79190104151;42612.360814587184;42684.146317074104;45012.77493612511;57116.42883571277;57768.71115644395;61220;62528.374716252256;63262.367376327486;6002.849928751816;7667.731629393167;8838.116188381367;8985.281177505653;9085.409448385833;7938.087119981045;10634.946825265824;11871.76256474883;13781.104228225133;14072.788908166181;11990.880091198977;12099.395030248277;12414.689632759253;12571.559995400117;12879.291638959947;11642.301461912313;11734.471948762497;11831.881681183078;12042.518299267931;12355.196912200678;12415.317157556421;12448.751024979269;12466.812997804858;12535.561255356019;12883.871161288267;8737.694180703646;9099.727008189764;9193.494357810117;9323.347365684609;9371.578278977326;9581.281403894596;11931.522739090338;11958.701032474257;12003.759924801281;12305 22:59:56 INFO - PROCESS | 8850 | |3;mootools.html;1430.3134495442187;1475.6089636246395;1583.461623048164;1688.0293831047152;1745.3454954392096;7625.504342217759;8099.352051835854;8103.91896081039;8107.7567672969835;8120.2691757741795;7055.506114571982;7284.125904891407;7580.5072670276395;7792.45452818303;7834.216578342177;2344.038944032947;2368.336865677613;2369.490559529701;2371.2530552875874;2383.1778036577352;2338.672585837984;2381.92854214373;2388.080588973249;2388.2715771689627;2389.6057150570136;2343.6601692754625;2346.9295921122393;2353.776391242829;2361.1027809432476;2382.845115067515;2281.600719874032;2293.1629955066364;2317.050009496107;2318.1654604342507;2321.8374713770045;2342.5783358995373;2343.0744855781873;2362.2204672458047;2362.5038741864228;2363.7163540375263;7726.420518461138;7842.372610191171;7842.451028428012;7852.097008843999;7853;4908.9263661045115;5017.096922553938;5026.47222041684;5028.396592408934;5029.245613158019;3155.085025342648;3228.1122691259857;3271.8691252349877;3272.9509057364157;3301.042697617688;1046.8639076920028;1047.5757318286107;1053.4732633683159;1129.0459561670457;1145.0610499390502;10619.469026548642;10637.9468102659;10678.679639610746;10684.732881677943;10731.195160363004;4373.190959672407;4605.769711514411;4618.884527886763;4663.626909847204;4673.252279635242;9264.073592640816;9285.978542360335;9288.164065234161;9290.442573445614;9292.442453452815;5166.354205724285;5167.224916262516;5168.043911876315;5168.328117344797;5172.689638621695;4258.318669012943;4269.957300426956;4585.564371384713;4593.19619066662;4771.928421073687;3889.552701439314;3934.6852251819787;3998.600139986036;4025.355943049157;4046.7369620975132;1322.821419108408;1326.0319966424563;1337.164272329794;1343.0732794372047;1365.6517588014992;924.1313165624292;999.4802702594756;1008.8032833597379;1022.5551884930079;1046.0585473074293;5774.88450230993;5899.410058994066;5926.67403292823;6145;6257.499400047986;978.7993461340408;990.6400906182326;992.6079198716467;1004;1031.7936412717486;3893.8831835044994;4113.670906327487;4179.707420480538;4256.127493863751;4302.784066205906;9310.743049688206;9562.330636855493;9609.471479068718;9689.951550242204;9699.70900872975;9470.90529094714;9633.759156021155;9651.552267159841;9652.710418687451;9653.03469653029;7457.440691948125;7617.238276172338;7624.923750762532;7651.1583725790115;7655.311022007934;5698.31620205578;5714.628549144292;5771.307443106854;5799.594028417971;5835.94164058354;8803.119688031145;8866.73399798007;8960.86558701607;9007.054259302678;9018.774530636787;8732.34507411934;8939.508327041814;9033.367664263438;9112.179903808688;9217.170454659114;6109.2974307955155;6712.228093769279;6786.185657721105;6864.965675171592;6981.581105133709;7807.024121984752;7853.09689385728;7853.764387068397;7861.213878612321;7885.605719714106;6635.767748128792;6702.932970670231;6724.462043036643;6768.898466523105;6881.243063263138;6859.9314006859295;7094.645267736696;7095.325944035309;7109.822254443473;7158.892616610651;6265.8120256392385;6326.525510586633;6372.203474565679;6372.713227904663;6409.038644203407;5072.746362681925;5134.9743251285;5183.81856635016;5197.818076367309;5212.50481204285;5129.384473863161;5138.845834624967;5267.9736601316745;5301.522862942354;5319.760610772602 22:59:56 INFO - PROCESS | 8850 | |4;prototype.html;352.6649682801338;361.86430088716725;364.1533434764173;369.11228495468407;369.79291596705866;5202.661826981243;5249.711265880375;5314.415414304428;5390.038321833449;5403.972980135104;5091.210862316347;5241.86895327617;5285.603579731526;5297.417284098746;5324.76038578264;4219.514755803076;4224.134052519226;4236.703430759848;4240.23675738367;4241.957580424202;4023.2556976959354;4198.433211516452;4228.76741779202;4229.97885010576;4230.302000169968;4170.499540055198;4176.2900306947895;4177.916441671165;4179.937300940488;4190.308599081163;4161.667066634662;4166.354215096665;4169.874903752877;4173.64524015459;4175.951555364571;3717.4795528626014;3720.5163328767358;3720.795356255405;3722.758020728644;3731.9440208396895;5042.218456139304;5162.328897243335;5193.68837869729;5204.34945631796;5231.398389185254;4753.857384278477;4757.286407038937;4760.6429517785955;4803.279508073817;4825.710457372569;5405.621606487547;5530.474604912527;5553.362547531374;5554.972225138848;5573.470520300565;4045.8583949561626;4061.598748431786;4067.8983025424304;4075.3275709508193;4096.754194748295;5671;5687.824080087101;5695.493982647622;5709.286339207599;5722.084466485384;4130.463039804806;4132.91734165321;4140.37894315849;4164.895877603023;4202.789860507023;4162.458880345535;4211.4525111735275;4212.410262563244;4223.113146239262;4245.1934132514725;4737.418107131622;4758.428988521399;4762.809487620457;4764.285357196379;4771.449278984344;5603.439656034364;5606.243157173811;5608.242887210256;5613.242212301368;5613.971930140323;1348.9882588058956;1351.189286428155;1365.4060483689627;1420.5028240115876;1433.6129245103764;961.5576834655997;985;989.5744829723144;995.4922989275377;998.0518507417981;5238.580913526908;5271.762770675329;5284.497972692588;5288.92066619001;5314.256004159421;5503.2020357048;5520.503154716014;5521.558275337963;5583.330000399897;5591.776328946878;5168.405633352213;5299.6025298102795;5334.946650533445;5347.652402593819;5363.517283444508;2928.6924872888467;2934.559816027613;2935.6036935013926;2946.9410611787644;2951.911442656724;5729.822667386366;5742.942570574241;5743.994800909824;5750.482456578928;5774.595778295479;5367.75845086972;5571.387147413781;5576;5596.188552659842;5641.379448260688;5702.771889124471;5705.800296989585;5739.62692424991;5739.957822354159;5763.164341170507;5245.265662807286;5462.105084305324;5517.337919449692;5523.6685798852195;5535.841022001342;5410.675359478444;5430.647007944471;5437.803683189692;5461.808836690697;5480.671159730429;5674.460926212003;5743.942560574341;5763.366029736641;5780.7398667060925;5795.855533452649;3951;4056.3104272273195;4062.614051665087;4069.616330447662;4117.423560701444;5442.809501667422;5467.507924286833;5478.506934375925;5499.862503437446;5523.547782635853;5445.537129343892;5528.640638358494;5576.832695019156;5586.748596313095;5597.80407685729;5583.832485025456;5591.384947655673;5592.608517403905;5594.38461769197;5596.384397716167;5300.814471493479;5571.804986825604;5579.246801681721;5595.272614560244;5597.468240517144;5638.351589567253;5639.210510528447;5652.576056795675;5670.546356291569;5675.31896172462;5498.505134537911;5554.50009499147;5564.165375193591;5566.192902029102;5571.777128914798 22:59:56 INFO - PROCESS | 8850 | |5;yui.html;780.7111368793547;825.2572684583873;846.9915300846992;881.8280435315108;910.2217603948624;14717.632059198526;15400.922995385008;15464.92267538662;15475.380984760624;15495.999999999985;13886.166829990183;13928.164310141374;13940.09389389689;13965;13967.650808729786;707.8831992721194;726.3499168244418;845.8181490979438;859.7248880358288;878.7144178142097;866.7009881590841;867.2758246863876;867.9349048821332;868.5961028121922;869.0917990699702;919.0763282900675;919.6919032124213;920.2499962530517;920.5075284722675;920.6685593186447;911.8541033434618;915.071202729227;915.9450432973977;916.1434059154711;916.4684482999877;675.8175292671001;675.9222689390684;676.3946268090081;676.4655921821754;677.0386051806447;15668.68662626741;15708.528744137695;15709.685806283811;15726.842731572653;15738.9213053934;14427.35076921541;14644.707105857824;15147.848521514754;15234.695306093927;15330.310136043905;11706;11798.865379174771;11987.700307492296;12041;12058.638240852788;3904.629060239273;3946.3488524393442;3950.8617198398206;3963.7027222958104;4058.492688413948;62665.37334626641;63075.36924630787;63496.36503634997;66090;66693.9995900057;11100.944495277472;11204.551817927355;11237;11494.540218391337;11573.305601663758;21850.781492185193;21882.45293867666;21882.562348752937;21892.12431502754;21933.341999740034;8509;8517.914820851836;8562.443441176303;8642.913570864212;8728.432651877607;4623.53764623535;4636.44362676481;4664.883377915511;4764.523547645208;4803.735794531334;3295.9176020599675;3422.0760394693793;3436.1237884339835;3440.8107554084263;3443.362977849106;579.6666916523017;583.8832233553306;591.6864062047035;593.252501847675;596.6062398816761;598.8981873081586;706.6678661029308;727.316322656701;732.2567593892204;758.3288789421401;9584.856227156599;9643.758906027266;9994.500274986221;10363.274570780124;10405.791884162274;641.8972964325778;689.2005273882372;689.5414549324743;701.919279282889;706.8621618784288;4239.202126596431;4559.3844830948065;4589.449266088091;4646.767661616906;4707.152712511781;83407.58296208602;91784.54107729418;93693.53153234326;94790;95046.52476737573;49458.752706236235;72580.2741972584;77409.83885241726;79697.88639891747;86668;71576.284237158;73086.26913730794;73137.63431182811;75278.62360688162;75371.62314188395;8939.463632182089;9059.275257979478;9489.525523723649;9561.760955976157;9593.328467007243;46366.536334637574;46708.299375508715;47071.76464117794;47194.29208561806;48165.518344816104;43597.34603980879;43810;57003.714981424826;65896.34103658902;68796.6560167196;11575.536978521102;11717.824232636687;11921.642350729491;12070.336131512851;12173.20874143178;13217.47130114823;13234.508213506195;13513.256770877302;13628;13642.727145456836;12312.630621081382;12361.690957725768;12369.134160608672;12497.625071247878;13052.738945221232;11928.522859085539;11933.4033298333;12046.146082629435;12087.456064476944;12427.75144497123;12356.443960022001;12360.072994525266;12446.937765311115;12504.74990500203;12816.679583010125;10375.792484150124;10433.739156520844;10474.319169253975;10566.101881340172;10661.946690266499;10301.433421161908;10451.372917624967;10652.680419587425;10685.252032357972;10743.623973160902 22:59:56 INFO - PROCESS | 8850 | __end_tp_report 22:59:56 INFO - PROCESS | 8850 | __start_cc_report 22:59:56 INFO - PROCESS | 8850 | _x_x_mozilla_cycle_collect,980 22:59:56 INFO - PROCESS | 8850 | __end_cc_report 22:59:56 INFO - PROCESS | 8850 | __startTimestamp1485327596358__endTimestamp 22:59:56 INFO - PROCESS | 8850 | 22:59:56 INFO - PROCESS | 8850 | ------- Summary: start ------- 22:59:56 INFO - PROCESS | 8850 | Number of tests: 6 22:59:56 INFO - PROCESS | 8850 | 22:59:56 INFO - PROCESS | 8850 | [#0] dojo.html Cycles:165 Average:5471.54 Median:5646.69 stddev:607.94 (10.8%) stddev-sans-first:582.34 22:59:56 INFO - PROCESS | 8850 | Values: 3168.3 3184.4 3200.8 3222.7 3233.2 5407.9 5475.5 5505.3 5518.5 5523.9 5537.6 5550.4 5562.4 5580.3 5583.6 4985.9 4996.0 5027.8 5054.7 5073.6 4945.3 5018.4 5086.0 5088.5 5119.3 4908.7 4975.0 5000.9 5019.1 5032.8 5031.4 5067.2 5067.7 5108.0 5118.7 4931.7 4990.0 5011.2 5016.7 5030.2 5320.4 5352.4 5367.1 5421.6 5424.9 5722.5 5736.2 5748.6 5810.2 5825.1 5855.9 5863.5 5870.3 5873.3 5884.4 5456.5 5501.7 5507.0 5533.0 5610.4 6043.2 6058.4 6060.7 6067.4 6070.8 5813.2 5814.7 5822.9 5832.6 5834.2 5734.7 5778.4 5811.1 5901.3 5912.2 5902.1 5914.4 5933.6 5944.8 5960.1 5883.7 5938.2 5957.7 5959.8 5971.0 4507.3 4508.8 4537.3 4547.4 4624.9 4075.6 4075.7 4077.6 4090.7 4127.9 5616.0 5620.8 5638.2 5646.7 5647.5 5655.3 5687.8 5881.8 5896.8 5917.4 5705.3 5760.0 5761.4 5792.2 5802.6 5156.0 5156.2 5156.5 5156.6 5179.9 5836.6 5932.9 6264.4 6268.0 6280.9 5835.3 5840.4 5863.7 5935.1 5967.3 6163.6 6177.5 6189.1 6197.7 6198.3 5605.9 5751.7 5801.9 5812.4 5812.7 5660.5 5718.4 5729.9 5753.7 5837.0 5591.5 5597.4 5631.4 5632.1 5644.7 5613.6 5619.1 5620.8 5623.2 5628.2 5502.9 5520.3 5676.5 5710.3 5745.6 5824.8 5826.3 5839.9 5842.8 5856.9 5466.5 5690.0 5693.1 5693.3 5703.9 22:59:56 INFO - PROCESS | 8850 | 22:59:56 INFO - PROCESS | 8850 | [#1] ext.html Cycles:180 Average:57272.26 Median:381324.00 stddev:106243.13 (27.9%) stddev-sans-first:106455.93 22:59:56 INFO - PROCESS | 8850 | Values: 591.2 613.0 648.4 657.6 659.9 34992.0 47017.3 47966.8 47995.5 48051.5 48708.3 49165.5 49179.0 49191.3 49194.5 8407.9 9070.1 9077.6 9213.4 9216.1 8478.9 10776.1 11027.1 11037.3 11335.1 11174.8 11251.7 11254.2 11255.3 11302.5 11010.3 11023.4 11072.3 11074.5 11091.4 10988.0 11065.6 11066.5 11074.4 11075.9 45013.3 45304.5 45317.3 45334.8 45385.1 3699.5 3798.1 3845.8 3951.2 4156.0 34173.3 34396.1 34705.0 35859.0 36004.5 4345.5 4386.9 4453.4 4466.1 4602.5 255550.0 259388.0 260356.0 261558.0 261967.0 65104.3 65426.7 65431.7 65449.7 65494.3 41062.0 42057.6 42070.6 43758.3 43896.8 19374.8 19576.4 19580.3 19591.4 19616.7 13676.4 13789.7 14055.1 14909.9 15183.1 20470.4 21421.4 21499.0 21532.5 21570.1 7599.6 7655.3 7681.5 7731.9 7786.1 1042.3 1043.5 1047.3 1121.3 1133.4 33957.5 34559.8 34758.8 34949.3 35169.0 1131.7 1144.8 1164.1 1167.2 1283.6 18070.7 18275.7 18313.6 18396.1 18508.7 519269.0 520361.0 520775.0 523292.0 525403.0 64020.7 64043.7 64203.0 64360.7 64535.4 1286.9 1353.6 1365.9 1409.5 1453.1 31406.2 35736.8 36183.8 36268.3 36296.8 55439.2 55753.7 55815.4 56087.0 56116.9 380224.0 380902.0 381011.0 381637.0 381725.0 27770.3 28632.3 28654.3 29253.7 31528.8 44778.0 49282.8 50895.7 51431.2 52262.2 43124.1 43219.1 43616.0 44360.0 45163.0 43360.6 43541.1 43637.8 44889.0 45540.5 43815.8 43891.3 45090.3 45097.0 45251.8 36682.8 39151.0 39166.6 39289.0 39759.4 29196.3 29522.0 29589.4 29714.6 29752.0 22:59:56 INFO - PROCESS | 8850 | 22:59:56 INFO - PROCESS | 8850 | [#2] jquery.html Cycles:180 Average:28614.66 Median:11930.93 stddev:76226.78 (638.9%) stddev-sans-first:76411.16 22:59:56 INFO - PROCESS | 8850 | Values: 393.5 394.2 410.4 410.9 423.5 14496.3 18584.8 20531.0 20556.7 21638.6 16672.9 16868.5 17860.4 20589.1 20607.5 1937.3 1942.0 1942.7 1943.1 2223.3 5813.9 5904.3 5904.9 5906.1 5910.3 4441.8 4639.1 6237.1 6454.1 6539.7 6425.0 6605.5 6636.4 6637.9 6641.3 5865.9 5868.2 5871.3 5871.5 5903.7 24543.9 24729.8 24763.9 24787.3 24982.6 2769.0 2788.9 3194.0 3201.0 3254.0 15068.8 15081.2 15518.8 15519.5 15579.1 1972.8 2041.7 2048.3 2053.2 2087.9 58698.7 78111.6 83981.6 88978.6 90928.5 10619.5 10770.9 11530.3 11592.4 11647.2 16433.1 16501.2 16512.8 16512.9 16530.1 8827.9 8833.6 9003.3 9026.1 9049.1 8875.6 8904.2 8960.0 9124.0 9140.6 6674.7 7030.1 7057.1 7091.2 7107.3 1996.3 2025.2 2037.8 2048.3 2064.7 957.0 1023.0 1055.1 1072.6 1083.1 20369.7 20893.0 20974.3 21135.2 21314.4 1058.2 1068.7 1112.3 1123.7 1142.9 10877.7 11733.4 12124.9 12150.9 12170.5 455800.0 456928.0 457806.0 459190.0 478210.0 76765.6 77289.0 96911.0 99459.0 99566.5 1017.9 1067.4 1090.0 1093.2 1104.6 17807.3 18145.4 18479.5 18653.7 18834.4 39742.2 41619.8 42612.4 42684.1 45012.8 57116.4 57768.7 61220.0 62528.4 63262.4 6002.8 7667.7 8838.1 8985.3 9085.4 7938.1 10634.9 11871.8 13781.1 14072.8 11990.9 12099.4 12414.7 12571.6 12879.3 11642.3 11734.5 11831.9 12042.5 12355.2 12415.3 12448.8 12466.8 12535.6 12883.9 8737.7 9099.7 9193.5 9323.3 9371.6 9581.3 11931.5 11958.7 12003.8 12305.0 22:59:56 INFO - PROCESS | 8850 | 22:59:56 INFO - PROCESS | 8850 | [#3] mootools.html Cycles:180 Average:5368.85 Median:5205.16 stddev:2818.50 (54.1%) stddev-sans-first:2810.86 22:59:56 INFO - PROCESS | 8850 | Values: 1430.3 1475.6 1583.5 1688.0 1745.3 7625.5 8099.4 8103.9 8107.8 8120.3 7055.5 7284.1 7580.5 7792.5 7834.2 2344.0 2368.3 2369.5 2371.3 2383.2 2338.7 2381.9 2388.1 2388.3 2389.6 2343.7 2346.9 2353.8 2361.1 2382.8 2281.6 2293.2 2317.1 2318.2 2321.8 2342.6 2343.1 2362.2 2362.5 2363.7 7726.4 7842.4 7842.5 7852.1 7853.0 4908.9 5017.1 5026.5 5028.4 5029.2 3155.1 3228.1 3271.9 3273.0 3301.0 1046.9 1047.6 1053.5 1129.0 1145.1 10619.5 10637.9 10678.7 10684.7 10731.2 4373.2 4605.8 4618.9 4663.6 4673.3 9264.1 9286.0 9288.2 9290.4 9292.4 5166.4 5167.2 5168.0 5168.3 5172.7 4258.3 4270.0 4585.6 4593.2 4771.9 3889.6 3934.7 3998.6 4025.4 4046.7 1322.8 1326.0 1337.2 1343.1 1365.7 924.1 999.5 1008.8 1022.6 1046.1 5774.9 5899.4 5926.7 6145.0 6257.5 978.8 990.6 992.6 1004.0 1031.8 3893.9 4113.7 4179.7 4256.1 4302.8 9310.7 9562.3 9609.5 9690.0 9699.7 9470.9 9633.8 9651.6 9652.7 9653.0 7457.4 7617.2 7624.9 7651.2 7655.3 5698.3 5714.6 5771.3 5799.6 5835.9 8803.1 8866.7 8960.9 9007.1 9018.8 8732.3 8939.5 9033.4 9112.2 9217.2 6109.3 6712.2 6786.2 6865.0 6981.6 7807.0 7853.1 7853.8 7861.2 7885.6 6635.8 6702.9 6724.5 6768.9 6881.2 6859.9 7094.6 7095.3 7109.8 7158.9 6265.8 6326.5 6372.2 6372.7 6409.0 5072.7 5135.0 5183.8 5197.8 5212.5 5129.4 5138.8 5268.0 5301.5 5319.8 22:59:56 INFO - PROCESS | 8850 | 22:59:56 INFO - PROCESS | 8850 | [#4] prototype.html Cycles:180 Average:4664.05 Median:5319.59 stddev:1341.86 (25.2%) stddev-sans-first:1306.03 22:59:56 INFO - PROCESS | 8850 | Values: 352.7 361.9 364.2 369.1 369.8 5202.7 5249.7 5314.4 5390.0 5404.0 5091.2 5241.9 5285.6 5297.4 5324.8 4219.5 4224.1 4236.7 4240.2 4242.0 4023.3 4198.4 4228.8 4230.0 4230.3 4170.5 4176.3 4177.9 4179.9 4190.3 4161.7 4166.4 4169.9 4173.6 4176.0 3717.5 3720.5 3720.8 3722.8 3731.9 5042.2 5162.3 5193.7 5204.3 5231.4 4753.9 4757.3 4760.6 4803.3 4825.7 5405.6 5530.5 5553.4 5555.0 5573.5 4045.9 4061.6 4067.9 4075.3 4096.8 5671.0 5687.8 5695.5 5709.3 5722.1 4130.5 4132.9 4140.4 4164.9 4202.8 4162.5 4211.5 4212.4 4223.1 4245.2 4737.4 4758.4 4762.8 4764.3 4771.4 5603.4 5606.2 5608.2 5613.2 5614.0 1349.0 1351.2 1365.4 1420.5 1433.6 961.6 985.0 989.6 995.5 998.1 5238.6 5271.8 5284.5 5288.9 5314.3 5503.2 5520.5 5521.6 5583.3 5591.8 5168.4 5299.6 5334.9 5347.7 5363.5 2928.7 2934.6 2935.6 2946.9 2951.9 5729.8 5742.9 5744.0 5750.5 5774.6 5367.8 5571.4 5576.0 5596.2 5641.4 5702.8 5705.8 5739.6 5740.0 5763.2 5245.3 5462.1 5517.3 5523.7 5535.8 5410.7 5430.6 5437.8 5461.8 5480.7 5674.5 5743.9 5763.4 5780.7 5795.9 3951.0 4056.3 4062.6 4069.6 4117.4 5442.8 5467.5 5478.5 5499.9 5523.5 5445.5 5528.6 5576.8 5586.7 5597.8 5583.8 5591.4 5592.6 5594.4 5596.4 5300.8 5571.8 5579.2 5595.3 5597.5 5638.4 5639.2 5652.6 5670.5 5675.3 5498.5 5554.5 5564.2 5566.2 5571.8 22:59:56 INFO - PROCESS | 8850 | 22:59:56 INFO - PROCESS | 8850 | [#5] yui.html Cycles:180 Average:17945.21 Median:4655.83 stddev:23857.29 (512.4%) stddev-sans-first:23889.40 22:59:56 INFO - PROCESS | 8850 | Values: 780.7 825.3 847.0 881.8 910.2 14717.6 15400.9 15464.9 15475.4 15496.0 13886.2 13928.2 13940.1 13965.0 13967.7 707.9 726.3 845.8 859.7 878.7 866.7 867.3 867.9 868.6 869.1 919.1 919.7 920.2 920.5 920.7 911.9 915.1 915.9 916.1 916.5 675.8 675.9 676.4 676.5 677.0 15668.7 15708.5 15709.7 15726.8 15738.9 14427.4 14644.7 15147.8 15234.7 15330.3 11706.0 11798.9 11987.7 12041.0 12058.6 3904.6 3946.3 3950.9 3963.7 4058.5 62665.4 63075.4 63496.4 66090.0 66694.0 11100.9 11204.6 11237.0 11494.5 11573.3 21850.8 21882.5 21882.6 21892.1 21933.3 8509.0 8517.9 8562.4 8642.9 8728.4 4623.5 4636.4 4664.9 4764.5 4803.7 3295.9 3422.1 3436.1 3440.8 3443.4 579.7 583.9 591.7 593.3 596.6 598.9 706.7 727.3 732.3 758.3 9584.9 9643.8 9994.5 10363.3 10405.8 641.9 689.2 689.5 701.9 706.9 4239.2 4559.4 4589.4 4646.8 4707.2 83407.6 91784.5 93693.5 94790.0 95046.5 49458.8 72580.3 77409.8 79697.9 86668.0 71576.3 73086.3 73137.6 75278.6 75371.6 8939.5 9059.3 9489.5 9561.8 9593.3 46366.5 46708.3 47071.8 47194.3 48165.5 43597.3 43810.0 57003.7 65896.3 68796.7 11575.5 11717.8 11921.6 12070.3 12173.2 13217.5 13234.5 13513.3 13628.0 13642.7 12312.6 12361.7 12369.1 12497.6 13052.7 11928.5 11933.4 12046.1 12087.5 12427.8 12356.4 12360.1 12446.9 12504.7 12816.7 10375.8 10433.7 10474.3 10566.1 10661.9 10301.4 10451.4 10652.7 10685.3 10743.6 22:59:56 INFO - PROCESS | 8850 | -------- Summary: end -------- 22:59:56 INFO - PROCESS | 8850 | 22:59:57 INFO - TEST-INFO | 8850: exit 0 22:59:57 INFO - TEST-OK | dromaeo_css | took 1113536ms 22:59:57 INFO - TEST-START | kraken 22:59:57 INFO - operating with platform_type : linux_ 22:59:57 INFO - Initialising browser for kraken test... 22:59:57 INFO - TEST-INFO | started process 9152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw0zK0w/profile http://localhost:52937/getInfo.html) 23:00:00 INFO - PROCESS | 9152 | __metrics Screen width/height:1600/1200 23:00:00 INFO - PROCESS | 9152 | colorDepth:24 23:00:00 INFO - PROCESS | 9152 | Browser inner width/height: 1024/697 23:00:00 INFO - PROCESS | 9152 | __metrics 23:00:01 INFO - PROCESS | 9152 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:00:01 INFO - PROCESS | 9152 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:00:01 INFO - PROCESS | 9152 | console.error: PushService: 23:00:01 INFO - PROCESS | 9152 | stateChangeProcessEnqueue: Error transitioning state 23:00:01 INFO - PROCESS | 9152 | UnknownError 23:00:02 INFO - TEST-INFO | 9152: exit 0 23:00:02 INFO - Browser initialized. 23:00:02 INFO - Running cycle 1/1 for kraken test... 23:00:02 INFO - TEST-INFO | started process 9246 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw0zK0w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:00:14 INFO - PROCESS | 9246 | RSS: Main: 141467648 23:00:14 INFO - PROCESS | 9246 | 23:00:16 INFO - PROCESS | 9246 | Cycle 1(1): loaded http://localhost:52937/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52937/tests/kraken/driver.html?testName=audio-beat-detection) 23:00:17 INFO - PROCESS | 9246 | RSS: Main: 183603200 23:00:17 INFO - PROCESS | 9246 | 23:00:20 INFO - PROCESS | 9246 | Cycle 1(1): loaded http://localhost:52937/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52937/tests/kraken/driver.html?testName=audio-dft) 23:00:20 INFO - PROCESS | 9246 | RSS: Main: 173559808 23:00:20 INFO - PROCESS | 9246 | 23:00:23 INFO - PROCESS | 9246 | Cycle 1(1): loaded http://localhost:52937/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52937/tests/kraken/driver.html?testName=audio-fft) 23:00:24 INFO - PROCESS | 9246 | RSS: Main: 264327168 23:00:24 INFO - PROCESS | 9246 | 23:00:26 INFO - PROCESS | 9246 | Cycle 1(1): loaded http://localhost:52937/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52937/tests/kraken/driver.html?testName=audio-oscillator) 23:00:26 INFO - PROCESS | 9246 | RSS: Main: 170745856 23:00:26 INFO - PROCESS | 9246 | 23:00:28 INFO - PROCESS | 9246 | Cycle 1(1): loaded http://localhost:52937/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52937/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:00:29 INFO - PROCESS | 9246 | RSS: Main: 173113344 23:00:29 INFO - PROCESS | 9246 | 23:00:32 INFO - PROCESS | 9246 | Cycle 1(1): loaded http://localhost:52937/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52937/tests/kraken/driver.html?testName=imaging-darkroom) 23:00:32 INFO - PROCESS | 9246 | RSS: Main: 211587072 23:00:32 INFO - PROCESS | 9246 | 23:00:36 INFO - PROCESS | 9246 | Cycle 1(1): loaded http://localhost:52937/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52937/tests/kraken/driver.html?testName=imaging-desaturate) 23:00:36 INFO - PROCESS | 9246 | RSS: Main: 211156992 23:00:36 INFO - PROCESS | 9246 | 23:00:39 INFO - PROCESS | 9246 | Cycle 1(1): loaded http://localhost:52937/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52937/tests/kraken/driver.html?testName=json-parse-financial) 23:00:40 INFO - PROCESS | 9246 | RSS: Main: 208998400 23:00:40 INFO - PROCESS | 9246 | 23:00:41 INFO - PROCESS | 9246 | Cycle 1(1): loaded http://localhost:52937/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52937/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:00:42 INFO - PROCESS | 9246 | RSS: Main: 171429888 23:00:42 INFO - PROCESS | 9246 | 23:00:43 INFO - PROCESS | 9246 | Cycle 1(1): loaded http://localhost:52937/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52937/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:00:44 INFO - PROCESS | 9246 | RSS: Main: 178372608 23:00:44 INFO - PROCESS | 9246 | 23:00:46 INFO - PROCESS | 9246 | Cycle 1(1): loaded http://localhost:52937/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52937/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:00:46 INFO - PROCESS | 9246 | RSS: Main: 187772928 23:00:46 INFO - PROCESS | 9246 | 23:00:49 INFO - PROCESS | 9246 | Cycle 1(1): loaded http://localhost:52937/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52937/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:00:50 INFO - PROCESS | 9246 | RSS: Main: 195637248 23:00:50 INFO - PROCESS | 9246 | 23:00:52 INFO - PROCESS | 9246 | Cycle 1(1): loaded http://localhost:52937/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52937/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:00:53 INFO - PROCESS | 9246 | RSS: Main: 192446464 23:00:53 INFO - PROCESS | 9246 | 23:00:55 INFO - PROCESS | 9246 | Cycle 1(1): loaded http://localhost:52937/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52937/tests/kraken/driver.html?testName=ai-astar) 23:00:55 INFO - PROCESS | 9246 | RSS: Main: 244670464 23:00:55 INFO - PROCESS | 9246 | 23:00:55 INFO - PROCESS | 9246 | __start_tp_report 23:00:55 INFO - PROCESS | 9246 | _x_x_mozilla_page_load 23:00:55 INFO - PROCESS | 9246 | _x_x_mozilla_page_load_details 23:00:55 INFO - PROCESS | 9246 | |i|pagename|runs| 23:00:55 INFO - PROCESS | 9246 | |0;ai-astar;105;112;111;111;111;111;113;110;112;111 23:00:55 INFO - PROCESS | 9246 | |1;audio-beat-detection;148;116;116;157;118;118;119;123;148;117 23:00:55 INFO - PROCESS | 9246 | |2;audio-dft;161;162;160;161;166;161;161;162;161;161 23:00:55 INFO - PROCESS | 9246 | |3;audio-fft;75;75;75;115;76;75;76;76;96;75 23:00:55 INFO - PROCESS | 9246 | |4;audio-oscillator;81;81;113;81;81;82;101;83;82;113 23:00:55 INFO - PROCESS | 9246 | |5;imaging-gaussian-blur;116;116;117;116;117;117;117;117;117;116 23:00:55 INFO - PROCESS | 9246 | |6;imaging-darkroom;147;146;146;145;146;146;147;146;147;146 23:00:55 INFO - PROCESS | 9246 | |7;imaging-desaturate;85;85;84;85;85;84;84;84;84;84 23:00:55 INFO - PROCESS | 9246 | |8;json-parse-financial;51;50;51;51;50;49;51;49;49;51 23:00:55 INFO - PROCESS | 9246 | |9;json-stringify-tinderbox;59;59;58;59;59;57;58;58;58;59 23:00:55 INFO - PROCESS | 9246 | |10;stanford-crypto-aes;82;80;75;74;74;74;73;75;74;74 23:00:55 INFO - PROCESS | 9246 | |11;stanford-crypto-ccm;124;130;127;127;128;120;125;130;157;121 23:00:55 INFO - PROCESS | 9246 | |12;stanford-crypto-pbkdf2;156;158;155;152;152;151;152;157;161;152 23:00:55 INFO - PROCESS | 9246 | |13;stanford-crypto-sha256-iterative;67;62;62;63;63;61;62;62;60;61 23:00:55 INFO - PROCESS | 9246 | __end_tp_report 23:00:55 INFO - PROCESS | 9246 | __start_cc_report 23:00:55 INFO - PROCESS | 9246 | _x_x_mozilla_cycle_collect,1561 23:00:55 INFO - PROCESS | 9246 | __end_cc_report 23:00:55 INFO - PROCESS | 9246 | __startTimestamp1485327655261__endTimestamp 23:00:55 INFO - PROCESS | 9246 | 23:00:55 INFO - PROCESS | 9246 | ------- Summary: start ------- 23:00:55 INFO - PROCESS | 9246 | Number of tests: 14 23:00:55 INFO - PROCESS | 9246 | 23:00:55 INFO - PROCESS | 9246 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:2.16 (1.9%) stddev-sans-first:0.87 23:00:55 INFO - PROCESS | 9246 | Values: 105.0 112.0 111.0 111.0 111.0 111.0 113.0 110.0 112.0 111.0 23:00:55 INFO - PROCESS | 9246 | 23:00:55 INFO - PROCESS | 9246 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:121.00 stddev:16.18 (13.4%) stddev-sans-first:15.46 23:00:55 INFO - PROCESS | 9246 | Values: 148.0 116.0 116.0 157.0 118.0 118.0 119.0 123.0 148.0 117.0 23:00:55 INFO - PROCESS | 9246 | 23:00:55 INFO - PROCESS | 9246 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.00 stddev:1.65 (1.0%) stddev-sans-first:1.73 23:00:55 INFO - PROCESS | 9246 | Values: 161.0 162.0 160.0 161.0 166.0 161.0 161.0 162.0 161.0 161.0 23:00:55 INFO - PROCESS | 9246 | 23:00:55 INFO - PROCESS | 9246 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.50 stddev:13.48 (17.8%) stddev-sans-first:14.09 23:00:55 INFO - PROCESS | 9246 | Values: 75.0 75.0 75.0 115.0 76.0 75.0 76.0 76.0 96.0 75.0 23:00:55 INFO - PROCESS | 9246 | 23:00:55 INFO - PROCESS | 9246 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:81.00 stddev:13.66 (16.9%) stddev-sans-first:14.11 23:00:55 INFO - PROCESS | 9246 | Values: 81.0 81.0 113.0 81.0 81.0 82.0 101.0 83.0 82.0 113.0 23:00:55 INFO - PROCESS | 9246 | 23:00:55 INFO - PROCESS | 9246 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 23:00:55 INFO - PROCESS | 9246 | Values: 116.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 23:00:55 INFO - PROCESS | 9246 | 23:00:55 INFO - PROCESS | 9246 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 23:00:55 INFO - PROCESS | 9246 | Values: 147.0 146.0 146.0 145.0 146.0 146.0 147.0 146.0 147.0 146.0 23:00:55 INFO - PROCESS | 9246 | 23:00:55 INFO - PROCESS | 9246 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 23:00:55 INFO - PROCESS | 9246 | Values: 85.0 85.0 84.0 85.0 85.0 84.0 84.0 84.0 84.0 84.0 23:00:55 INFO - PROCESS | 9246 | 23:00:55 INFO - PROCESS | 9246 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:51.00 stddev:0.92 (1.8%) stddev-sans-first:0.93 23:00:55 INFO - PROCESS | 9246 | Values: 51.0 50.0 51.0 51.0 50.0 49.0 51.0 49.0 49.0 51.0 23:00:55 INFO - PROCESS | 9246 | 23:00:55 INFO - PROCESS | 9246 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:59.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 23:00:55 INFO - PROCESS | 9246 | Values: 59.0 59.0 58.0 59.0 59.0 57.0 58.0 58.0 58.0 59.0 23:00:55 INFO - PROCESS | 9246 | 23:00:55 INFO - PROCESS | 9246 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:74.50 stddev:2.99 (4.0%) stddev-sans-first:2.05 23:00:55 INFO - PROCESS | 9246 | Values: 82.0 80.0 75.0 74.0 74.0 74.0 73.0 75.0 74.0 74.0 23:00:55 INFO - PROCESS | 9246 | 23:00:55 INFO - PROCESS | 9246 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:127.50 stddev:10.44 (8.2%) stddev-sans-first:10.92 23:00:55 INFO - PROCESS | 9246 | Values: 124.0 130.0 127.0 127.0 128.0 120.0 125.0 130.0 157.0 121.0 23:00:55 INFO - PROCESS | 9246 | 23:00:55 INFO - PROCESS | 9246 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.60 Median:155.50 stddev:3.34 (2.1%) stddev-sans-first:3.50 23:00:55 INFO - PROCESS | 9246 | Values: 156.0 158.0 155.0 152.0 152.0 151.0 152.0 157.0 161.0 152.0 23:00:55 INFO - PROCESS | 9246 | 23:00:55 INFO - PROCESS | 9246 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:1.89 (3.0%) stddev-sans-first:0.97 23:00:55 INFO - PROCESS | 9246 | Values: 67.0 62.0 62.0 63.0 63.0 61.0 62.0 62.0 60.0 61.0 23:00:55 INFO - PROCESS | 9246 | -------- Summary: end -------- 23:00:55 INFO - PROCESS | 9246 | 23:00:56 INFO - TEST-INFO | 9246: exit 0 23:00:56 INFO - TEST-OK | kraken | took 59136ms 23:00:56 INFO - SUITE-END | took 1172s 23:00:56 INFO - Completed test suite (00:19:32) 23:00:56 INFO - javascript benchmark 23:00:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3168.255459966908, 3184.4427225235577, 3200.7919485233456, 3222.7260682841957, 3233.2401885556906, 5407.945920540798, 5475.534579560737, 5505.3393592768825, 5518.503334699876, 5523.861903452405, 5537.58468114892, 5550.417206193352, 5562.360328562217, 5580.274564306635, 5583.58123140764, 4985.875353116183, 4996.0, 5027.798888044474, 5054.747262636872, 5073.619478539124, 4945.282933974571, 5018.447970723218, 5086.033653605803, 5088.465711100337, 5119.308893299394, 4908.680935739166, 4975.029869175512, 5000.949990500103, 5019.071471777715, 5032.798688052492, 5031.421386540558, 5067.239914012891, 5067.695938243717, 5108.029474399889, 5118.744062796883, 4931.65478416511, 4990.001999600095, 5011.198208286693, 5016.673916195436, 5030.245463180516, 5320.388155362106, 5352.384475785257, 5367.114426119724, 5421.620486565942, 5424.945750542483, 5722.54219662426, 5736.168255602956, 5748.5688573357165, 5810.215620891167, 5825.0679891217205, 5855.882882342372, 5863.5016023638045, 5870.324912635059, 5873.2658417697785, 5884.411558844125, 5456.454354564512, 5501.724913754297, 5507.008738427082, 5533.03171944908, 5610.410906854803, 6043.214382130383, 6058.424449677362, 6060.727267272983, 6067.362926892612, 6070.757169713162, 5813.186153938452, 5814.709264536757, 5822.912656310159, 5832.591718579659, 5834.154047663065, 5734.655920644775, 5778.393268706809, 5811.099279611667, 5901.262342207224, 5912.23140991677, 5902.1146827976145, 5914.4381283777975, 5933.58464907461, 5944.762209511658, 5960.105984102419, 5883.676397798162, 5938.2280303560265, 5957.702114894238, 5959.821205363846, 5970.9701451492465, 4507.323901414748, 4508.752018638941, 4537.296719008559, 4547.431571053618, 4624.930626040612, 4075.612816782401, 4075.735077219971, 4077.561442706621, 4090.6931980101613, 4127.938080928789, 5616.0, 5620.775168993277, 5638.182463542763, 5646.689432081275, 5647.548196144298, 5655.349634791969, 5687.829365119053, 5881.823545293648, 5896.7936122235515, 5917.437843404869, 5705.286839145107, 5760.049591817387, 5761.39505351932, 5792.218050563204, 5802.564807639444, 5155.9742201288755, 5156.226566015128, 5156.458571849902, 5156.639035267495, 5179.896402071938, 5836.649801011953, 5932.911006334994, 6264.37356264379, 6267.968660156761, 6280.937190628127, 5835.328937172279, 5840.357560668238, 5863.706814659165, 5935.0503919372695, 5967.283925928743, 6163.568550201443, 6177.536684748752, 6189.133521307111, 6197.721102550306, 6198.2871969722255, 5605.943940560543, 5751.683657398716, 5801.94198058014, 5812.360640329645, 5812.709364531841, 5660.51885589713, 5718.428157184415, 5729.856753581027, 5753.683547404933, 5836.970815145897, 5591.524720398649, 5597.356304025089, 5631.352394474524, 5632.070708333079, 5644.689542075225, 5613.607047506635, 5619.100943848965, 5620.775168993358, 5623.212750215055, 5628.155776633538, 5502.862428439161, 5520.282363292747, 5676.460736230051, 5710.2576665033275, 5745.569082318759, 5824.796132135524, 5826.271716035496, 5839.912401313899, 5842.795502157574, 5856.853578660568, 5466.508014278734, 5690.0, 5693.060644993529, 5693.3168019837885, 5703.8859222816145], "value": 5431.507689578099, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.2077815726925, 612.9632222066675, 648.3581254557986, 657.6218674262298, 659.9043138744885, 34992.0, 47017.29474057887, 47966.76016619912, 47995.5200447995, 48051.51948480514, 48708.2693759593, 49165.50834491663, 49179.0, 49191.262131067975, 49194.50805491944, 8407.873881891777, 9070.138336857988, 9077.591508382106, 9213.447193168398, 9216.124468175512, 8478.872816907751, 10776.137908967303, 11027.062699670538, 11037.282576632533, 11335.093192544618, 11174.776504469906, 11251.662450126509, 11254.155938304619, 11255.268407553524, 11302.491387887565, 11010.339379637207, 11023.44882755863, 11072.280301780358, 11074.501647425885, 11091.389973551451, 10988.0, 11065.557377704883, 11066.502007409686, 11074.390908500029, 11075.889241107567, 45013.32480012802, 45304.54695453069, 45317.32024019642, 45334.77332613316, 45385.09229815385, 3699.463577781207, 3798.0694729791376, 3845.7692538447504, 3951.249262640089, 4156.0, 34173.31653366919, 34396.14009649754, 34705.0, 35859.0, 36004.459933101025, 4345.521992580813, 4386.912261754779, 4453.354263631788, 4466.0844526871915, 4602.493725690171, 255550.0, 259388.0, 260356.0, 261558.0, 261967.0, 65104.34895650983, 65426.67286663631, 65431.67284163644, 65449.67275163594, 65494.34505654978, 41062.0, 42057.57942420598, 42070.57929420728, 43758.34362484565, 43896.78051609721, 19374.8062519373, 19576.412707618794, 19580.314688985818, 19591.412257632295, 19616.70574941377, 13676.384562694702, 13789.655258618413, 14055.086419382707, 14909.850901491063, 15183.089014659156, 20470.38588842337, 21421.357359279245, 21499.0, 21532.461688457915, 21570.137194512045, 7599.620018999028, 7655.311022008046, 7681.539107653447, 7731.922680773233, 7786.104597971193, 1042.2964498963322, 1043.5043354406596, 1047.261680515235, 1121.3336713239712, 1133.3709791066037, 33957.471913763446, 34559.82720086434, 34758.82620586881, 34949.30101398009, 35169.0, 1131.7057565033151, 1144.782491326662, 1164.0687450039934, 1167.1654766841748, 1283.646997075793, 18070.728939065924, 18275.72586411205, 18313.633727325647, 18396.080195990413, 18508.722369164472, 519269.0, 520361.0, 520775.0, 523292.0, 525403.0, 64020.67989660022, 64043.6797816008, 64203.0, 64360.678196608715, 64535.354646453874, 1286.9163504372186, 1353.6074538383955, 1365.938532766028, 1409.5348534983432, 1453.077295917079, 31406.214844628154, 35736.821315894296, 36183.81908090548, 36268.27463450769, 36296.81851590725, 55439.16841247304, 55753.72123139358, 55815.44184558102, 56087.0, 56116.8776624457, 380224.0, 380902.0, 381011.0, 381637.0, 381725.0, 27770.305742356602, 28632.284192894513, 28654.283642909093, 29253.70746292595, 31528.842355788074, 44778.0, 49282.75358623184, 50895.745521272154, 51431.22853157131, 52262.21606675979, 43124.13751725011, 43219.13561728685, 43616.0, 44360.0, 45163.0, 43360.566394336915, 43541.10929201768, 43637.78181109074, 44889.0, 45540.544594553634, 43815.78092109519, 43891.34162987622, 45090.323645144694, 45097.0, 45251.77374113108, 36682.8165859169, 39151.044710512084, 39166.608333916294, 39289.0, 39759.403608946464, 29196.27009324699, 29522.0, 29589.408211836075, 29714.554281686225, 29752.0], "value": 21306.50819205949, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.5297319702956, 394.20370850881204, 410.3577900585584, 410.8746832216174, 423.5193055881575, 14496.347664355102, 18584.814151858478, 20531.0, 20556.69164962525, 21638.567228655418, 16672.916635416837, 16868.49394518163, 17860.374886878963, 20589.073491692874, 20607.484812879684, 1937.2541571495005, 1942.019280263465, 1942.7280180774703, 1943.1061711612674, 2223.288547664744, 5813.854653633672, 5904.321003084658, 5904.940950590482, 5906.114082887559, 5910.290765108171, 4441.800118994637, 4639.118567472169, 6237.095621134933, 6454.096426500294, 6539.6730163491875, 6424.967875160641, 6605.471562275006, 6636.369544893228, 6637.900431493532, 6641.335866413368, 5865.941340586625, 5868.178455016301, 5871.295444546682, 5871.471567558898, 5903.704814759245, 24543.877280613662, 24729.752702473106, 24763.87618061916, 24787.25638230856, 24982.625260621106, 2769.0031588628076, 2788.860556972143, 3193.979348927289, 3201.0, 3254.007527704049, 15068.849311506854, 15081.170535620537, 15518.844811551853, 15519.456819011393, 15579.143147126904, 1972.80271972803, 2041.7243672104373, 2048.262625454835, 2053.168466770945, 2087.8642888212216, 58698.70650646762, 78111.609441953, 83981.58009209915, 88978.5551072247, 90928.54535727279, 10619.522121504551, 10770.892291077145, 11530.308181509135, 11592.420378981018, 11647.242929209575, 16433.09617970999, 16501.174941252888, 16512.83487165137, 16512.917435412746, 16530.09084500364, 8827.925437522177, 8833.60248788806, 9003.324750643596, 9026.052264512264, 9049.09509049103, 8875.556222188865, 8904.154105359981, 8959.955200223958, 9123.996360400351, 9140.588673509708, 6674.699638516278, 7030.050943122613, 7057.082579264663, 7091.219965803757, 7107.324804143598, 1996.3212507747146, 2025.2405347994502, 2037.7758446570865, 2048.2523878784436, 2064.7109404683356, 956.9856452153223, 1022.9744256393501, 1055.1295181475314, 1072.554889720757, 1083.101026148295, 20369.694454583194, 20893.0, 20974.2659006934, 21135.154593816384, 21314.424280972326, 1058.2486434631498, 1068.6526878764278, 1112.3214838948236, 1123.7471568896933, 1142.868570114431, 10877.728056798644, 11733.35466549348, 12124.939375303067, 12150.939245303716, 12170.45232964501, 455800.0, 456928.0, 457806.0, 459190.0, 478210.0, 76765.6161719199, 77289.0, 96911.0, 99459.0, 99566.5021674887, 1017.9491025448846, 1067.3649178738483, 1089.9727506812394, 1093.1637297467444, 1104.5747387255803, 17807.287708492033, 18145.364912228008, 18479.53801154982, 18653.656977644303, 18834.434966951012, 39742.205155897296, 41619.79190104151, 42612.360814587184, 42684.146317074104, 45012.77493612511, 57116.42883571277, 57768.71115644395, 61220.0, 62528.374716252256, 63262.367376327486, 6002.849928751816, 7667.731629393167, 8838.116188381367, 8985.281177505653, 9085.409448385833, 7938.087119981045, 10634.946825265824, 11871.76256474883, 13781.104228225133, 14072.788908166181, 11990.880091198977, 12099.395030248277, 12414.689632759253, 12571.559995400117, 12879.291638959947, 11642.301461912313, 11734.471948762497, 11831.881681183078, 12042.518299267931, 12355.196912200678, 12415.317157556421, 12448.751024979269, 12466.812997804858, 12535.561255356019, 12883.871161288267, 8737.694180703646, 9099.727008189764, 9193.494357810117, 9323.347365684609, 9371.578278977326, 9581.281403894596, 11931.522739090338, 11958.701032474257, 12003.759924801281, 12305.0], "value": 9512.010370431492, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.3134495442187, 1475.6089636246395, 1583.461623048164, 1688.0293831047152, 1745.3454954392096, 7625.504342217759, 8099.352051835854, 8103.91896081039, 8107.7567672969835, 8120.2691757741795, 7055.506114571982, 7284.125904891407, 7580.5072670276395, 7792.45452818303, 7834.216578342177, 2344.038944032947, 2368.336865677613, 2369.490559529701, 2371.2530552875874, 2383.1778036577352, 2338.672585837984, 2381.92854214373, 2388.080588973249, 2388.2715771689627, 2389.6057150570136, 2343.6601692754625, 2346.9295921122393, 2353.776391242829, 2361.1027809432476, 2382.845115067515, 2281.600719874032, 2293.1629955066364, 2317.050009496107, 2318.1654604342507, 2321.8374713770045, 2342.5783358995373, 2343.0744855781873, 2362.2204672458047, 2362.5038741864228, 2363.7163540375263, 7726.420518461138, 7842.372610191171, 7842.451028428012, 7852.097008843999, 7853.0, 4908.9263661045115, 5017.096922553938, 5026.47222041684, 5028.396592408934, 5029.245613158019, 3155.085025342648, 3228.1122691259857, 3271.8691252349877, 3272.9509057364157, 3301.042697617688, 1046.8639076920028, 1047.5757318286107, 1053.4732633683159, 1129.0459561670457, 1145.0610499390502, 10619.469026548642, 10637.9468102659, 10678.679639610746, 10684.732881677943, 10731.195160363004, 4373.190959672407, 4605.769711514411, 4618.884527886763, 4663.626909847204, 4673.252279635242, 9264.073592640816, 9285.978542360335, 9288.164065234161, 9290.442573445614, 9292.442453452815, 5166.354205724285, 5167.224916262516, 5168.043911876315, 5168.328117344797, 5172.689638621695, 4258.318669012943, 4269.957300426956, 4585.564371384713, 4593.19619066662, 4771.928421073687, 3889.552701439314, 3934.6852251819787, 3998.600139986036, 4025.355943049157, 4046.7369620975132, 1322.821419108408, 1326.0319966424563, 1337.164272329794, 1343.0732794372047, 1365.6517588014992, 924.1313165624292, 999.4802702594756, 1008.8032833597379, 1022.5551884930079, 1046.0585473074293, 5774.88450230993, 5899.410058994066, 5926.67403292823, 6145.0, 6257.499400047986, 978.7993461340408, 990.6400906182326, 992.6079198716467, 1004.0, 1031.7936412717486, 3893.8831835044994, 4113.670906327487, 4179.707420480538, 4256.127493863751, 4302.784066205906, 9310.743049688206, 9562.330636855493, 9609.471479068718, 9689.951550242204, 9699.70900872975, 9470.90529094714, 9633.759156021155, 9651.552267159841, 9652.710418687451, 9653.03469653029, 7457.440691948125, 7617.238276172338, 7624.923750762532, 7651.1583725790115, 7655.311022007934, 5698.31620205578, 5714.628549144292, 5771.307443106854, 5799.594028417971, 5835.94164058354, 8803.119688031145, 8866.73399798007, 8960.86558701607, 9007.054259302678, 9018.774530636787, 8732.34507411934, 8939.508327041814, 9033.367664263438, 9112.179903808688, 9217.170454659114, 6109.2974307955155, 6712.228093769279, 6786.185657721105, 6864.965675171592, 6981.581105133709, 7807.024121984752, 7853.09689385728, 7853.764387068397, 7861.213878612321, 7885.605719714106, 6635.767748128792, 6702.932970670231, 6724.462043036643, 6768.898466523105, 6881.243063263138, 6859.9314006859295, 7094.645267736696, 7095.325944035309, 7109.822254443473, 7158.892616610651, 6265.8120256392385, 6326.525510586633, 6372.203474565679, 6372.713227904663, 6409.038644203407, 5072.746362681925, 5134.9743251285, 5183.81856635016, 5197.818076367309, 5212.50481204285, 5129.384473863161, 5138.845834624967, 5267.9736601316745, 5301.522862942354, 5319.760610772602], "value": 4428.912865928361, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.6649682801338, 361.86430088716725, 364.1533434764173, 369.11228495468407, 369.79291596705866, 5202.661826981243, 5249.711265880375, 5314.415414304428, 5390.038321833449, 5403.972980135104, 5091.210862316347, 5241.86895327617, 5285.603579731526, 5297.417284098746, 5324.76038578264, 4219.514755803076, 4224.134052519226, 4236.703430759848, 4240.23675738367, 4241.957580424202, 4023.2556976959354, 4198.433211516452, 4228.76741779202, 4229.97885010576, 4230.302000169968, 4170.499540055198, 4176.2900306947895, 4177.916441671165, 4179.937300940488, 4190.308599081163, 4161.667066634662, 4166.354215096665, 4169.874903752877, 4173.64524015459, 4175.951555364571, 3717.4795528626014, 3720.5163328767358, 3720.795356255405, 3722.758020728644, 3731.9440208396895, 5042.218456139304, 5162.328897243335, 5193.68837869729, 5204.34945631796, 5231.398389185254, 4753.857384278477, 4757.286407038937, 4760.6429517785955, 4803.279508073817, 4825.710457372569, 5405.621606487547, 5530.474604912527, 5553.362547531374, 5554.972225138848, 5573.470520300565, 4045.8583949561626, 4061.598748431786, 4067.8983025424304, 4075.3275709508193, 4096.754194748295, 5671.0, 5687.824080087101, 5695.493982647622, 5709.286339207599, 5722.084466485384, 4130.463039804806, 4132.91734165321, 4140.37894315849, 4164.895877603023, 4202.789860507023, 4162.458880345535, 4211.4525111735275, 4212.410262563244, 4223.113146239262, 4245.1934132514725, 4737.418107131622, 4758.428988521399, 4762.809487620457, 4764.285357196379, 4771.449278984344, 5603.439656034364, 5606.243157173811, 5608.242887210256, 5613.242212301368, 5613.971930140323, 1348.9882588058956, 1351.189286428155, 1365.4060483689627, 1420.5028240115876, 1433.6129245103764, 961.5576834655997, 985.0, 989.5744829723144, 995.4922989275377, 998.0518507417981, 5238.580913526908, 5271.762770675329, 5284.497972692588, 5288.92066619001, 5314.256004159421, 5503.2020357048, 5520.503154716014, 5521.558275337963, 5583.330000399897, 5591.776328946878, 5168.405633352213, 5299.6025298102795, 5334.946650533445, 5347.652402593819, 5363.517283444508, 2928.6924872888467, 2934.559816027613, 2935.6036935013926, 2946.9410611787644, 2951.911442656724, 5729.822667386366, 5742.942570574241, 5743.994800909824, 5750.482456578928, 5774.595778295479, 5367.75845086972, 5571.387147413781, 5576.0, 5596.188552659842, 5641.379448260688, 5702.771889124471, 5705.800296989585, 5739.62692424991, 5739.957822354159, 5763.164341170507, 5245.265662807286, 5462.105084305324, 5517.337919449692, 5523.6685798852195, 5535.841022001342, 5410.675359478444, 5430.647007944471, 5437.803683189692, 5461.808836690697, 5480.671159730429, 5674.460926212003, 5743.942560574341, 5763.366029736641, 5780.7398667060925, 5795.855533452649, 3951.0, 4056.3104272273195, 4062.614051665087, 4069.616330447662, 4117.423560701444, 5442.809501667422, 5467.507924286833, 5478.506934375925, 5499.862503437446, 5523.547782635853, 5445.537129343892, 5528.640638358494, 5576.832695019156, 5586.748596313095, 5597.80407685729, 5583.832485025456, 5591.384947655673, 5592.608517403905, 5594.38461769197, 5596.384397716167, 5300.814471493479, 5571.804986825604, 5579.246801681721, 5595.272614560244, 5597.468240517144, 5638.351589567253, 5639.210510528447, 5652.576056795675, 5670.546356291569, 5675.31896172462, 5498.505134537911, 5554.50009499147, 5564.165375193591, 5566.192902029102, 5571.777128914798], "value": 4244.820256620661, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.7111368793547, 825.2572684583873, 846.9915300846992, 881.8280435315108, 910.2217603948624, 14717.632059198526, 15400.922995385008, 15464.92267538662, 15475.380984760624, 15495.999999999985, 13886.166829990183, 13928.164310141374, 13940.09389389689, 13965.0, 13967.650808729786, 707.8831992721194, 726.3499168244418, 845.8181490979438, 859.7248880358288, 878.7144178142097, 866.7009881590841, 867.2758246863876, 867.9349048821332, 868.5961028121922, 869.0917990699702, 919.0763282900675, 919.6919032124213, 920.2499962530517, 920.5075284722675, 920.6685593186447, 911.8541033434618, 915.071202729227, 915.9450432973977, 916.1434059154711, 916.4684482999877, 675.8175292671001, 675.9222689390684, 676.3946268090081, 676.4655921821754, 677.0386051806447, 15668.68662626741, 15708.528744137695, 15709.685806283811, 15726.842731572653, 15738.9213053934, 14427.35076921541, 14644.707105857824, 15147.848521514754, 15234.695306093927, 15330.310136043905, 11706.0, 11798.865379174771, 11987.700307492296, 12041.0, 12058.638240852788, 3904.629060239273, 3946.3488524393442, 3950.8617198398206, 3963.7027222958104, 4058.492688413948, 62665.37334626641, 63075.36924630787, 63496.36503634997, 66090.0, 66693.9995900057, 11100.944495277472, 11204.551817927355, 11237.0, 11494.540218391337, 11573.305601663758, 21850.781492185193, 21882.45293867666, 21882.562348752937, 21892.12431502754, 21933.341999740034, 8509.0, 8517.914820851836, 8562.443441176303, 8642.913570864212, 8728.432651877607, 4623.53764623535, 4636.44362676481, 4664.883377915511, 4764.523547645208, 4803.735794531334, 3295.9176020599675, 3422.0760394693793, 3436.1237884339835, 3440.8107554084263, 3443.362977849106, 579.6666916523017, 583.8832233553306, 591.6864062047035, 593.252501847675, 596.6062398816761, 598.8981873081586, 706.6678661029308, 727.316322656701, 732.2567593892204, 758.3288789421401, 9584.856227156599, 9643.758906027266, 9994.500274986221, 10363.274570780124, 10405.791884162274, 641.8972964325778, 689.2005273882372, 689.5414549324743, 701.919279282889, 706.8621618784288, 4239.202126596431, 4559.3844830948065, 4589.449266088091, 4646.767661616906, 4707.152712511781, 83407.58296208602, 91784.54107729418, 93693.53153234326, 94790.0, 95046.52476737573, 49458.752706236235, 72580.2741972584, 77409.83885241726, 79697.88639891747, 86668.0, 71576.284237158, 73086.26913730794, 73137.63431182811, 75278.62360688162, 75371.62314188395, 8939.463632182089, 9059.275257979478, 9489.525523723649, 9561.760955976157, 9593.328467007243, 46366.536334637574, 46708.299375508715, 47071.76464117794, 47194.29208561806, 48165.518344816104, 43597.34603980879, 43810.0, 57003.714981424826, 65896.34103658902, 68796.6560167196, 11575.536978521102, 11717.824232636687, 11921.642350729491, 12070.336131512851, 12173.20874143178, 13217.47130114823, 13234.508213506195, 13513.256770877302, 13628.0, 13642.727145456836, 12312.630621081382, 12361.690957725768, 12369.134160608672, 12497.625071247878, 13052.738945221232, 11928.522859085539, 11933.4033298333, 12046.146082629435, 12087.456064476944, 12427.75144497123, 12356.443960022001, 12360.072994525266, 12446.937765311115, 12504.74990500203, 12816.679583010125, 10375.792484150124, 10433.739156520844, 10474.319169253975, 10566.101881340172, 10661.946690266499, 10301.433421161908, 10451.372917624967, 10652.680419587425, 10685.252032357972, 10743.623973160902], "value": 7248.996023611569, "unit": "score"}], "name": "dromaeo_css", "value": 7289.504631137224, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 111.0, 111.0, 111.0, 111.0, 113.0, 110.0, 112.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 116.0, 116.0, 157.0, 118.0, 118.0, 119.0, 123.0, 148.0, 117.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 161.0, 166.0, 161.0, 161.0, 162.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 115.0, 76.0, 75.0, 76.0, 76.0, 96.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 113.0, 81.0, 81.0, 82.0, 101.0, 83.0, 82.0, 113.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 51.0, 50.0, 49.0, 51.0, 49.0, 49.0, 51.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 59.0, 59.0, 57.0, 58.0, 58.0, 58.0, 59.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 75.0, 74.0, 74.0, 74.0, 73.0, 75.0, 74.0, 74.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 130.0, 127.0, 127.0, 128.0, 120.0, 125.0, 130.0, 157.0, 121.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 158.0, 155.0, 152.0, 152.0, 151.0, 152.0, 157.0, 161.0, 152.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 62.0, 62.0, 63.0, 63.0, 61.0, 62.0, 62.0, 60.0, 61.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1448.6, "alertThreshold": 2.0}]} 23:00:56 INFO - Return code: 0 23:00:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:00:56 INFO - # TBPL SUCCESS # 23:00:56 INFO - Running post-action listener: _resource_record_post_action 23:00:56 INFO - [mozharness: 2017-01-25 07:00:56.571334Z] Finished run-tests step (success) 23:00:56 INFO - Running post-run listener: _resource_record_post_run 23:00:56 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 327651328; Read time: 28; Write time: 218180 23:00:56 INFO - TinderboxPrint: CPU usage
13.0% 23:00:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 28 23:00:56 INFO - TinderboxPrint: I/O write bytes / time
327,651,328 / 218,180 23:00:56 INFO - TinderboxPrint: CPU idle
8,246.4 (87.0%) 23:00:56 INFO - TinderboxPrint: CPU user
1,187.2 (12.5%) 23:00:56 INFO - TinderboxPrint: Swap in / out
0 / 0 23:00:56 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 107200512; Read time: 0; Write time: 106808 23:00:56 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 220450816; Read time: 28; Write time: 111372 23:00:57 INFO - Running post-run listener: _upload_blobber_files 23:00:57 INFO - Blob upload gear active. 23:00:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:00:57 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 23:00:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:00:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:00:57 INFO - (blobuploader) - INFO - Open directory for files ... 23:00:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:00:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:00:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:00:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:00:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:00:58 INFO - (blobuploader) - INFO - Done attempting. 23:00:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:00:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:00:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:01:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:01:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:01:01 INFO - (blobuploader) - INFO - Done attempting. 23:01:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:01:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:01:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:01:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:01:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:01:02 INFO - (blobuploader) - INFO - Done attempting. 23:01:02 INFO - (blobuploader) - INFO - Iteration through files over. 23:01:02 INFO - Return code: 0 23:01:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:01:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:01:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d3645dce17825a5740e23a87cec62d920ee85301d3cadfe94b6e0494d92a236264e16e64ee48b357ae9482226e6fc25ca8d6ed4209b7ed3ebc0fae4425b2104", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bd74b286f9114075c044c99a56711738e7ae247e8daa84e556bbacdef66d4f3757f1260387b28d904d5e1c91949ef7c764ab8b3ca3f4f7980a7d2f3c8dfb6b0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9fb017e873ffc23fbc940d0920f5564e9fba64d9ab3767d1257e3a79d9d0758f9f2dbeba802d7e4e26c192b5b48703ff7e38611fee5ab1997f087652ee28b06a"} 23:01:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:01:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:01:02 INFO - Contents: 23:01:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d3645dce17825a5740e23a87cec62d920ee85301d3cadfe94b6e0494d92a236264e16e64ee48b357ae9482226e6fc25ca8d6ed4209b7ed3ebc0fae4425b2104", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bd74b286f9114075c044c99a56711738e7ae247e8daa84e556bbacdef66d4f3757f1260387b28d904d5e1c91949ef7c764ab8b3ca3f4f7980a7d2f3c8dfb6b0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9fb017e873ffc23fbc940d0920f5564e9fba64d9ab3767d1257e3a79d9d0758f9f2dbeba802d7e4e26c192b5b48703ff7e38611fee5ab1997f087652ee28b06a"} 23:01:02 INFO - Running post-run listener: copy_logs_to_upload_dir 23:01:02 INFO - Copying logs to upload dir... 23:01:02 INFO - mkdir: /builds/slave/test/build/upload/logs 23:01:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.472298 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-01-24 23:01:01.910363) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 23:01:01.915171) ========= 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=6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d3645dce17825a5740e23a87cec62d920ee85301d3cadfe94b6e0494d92a236264e16e64ee48b357ae9482226e6fc25ca8d6ed4209b7ed3ebc0fae4425b2104", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bd74b286f9114075c044c99a56711738e7ae247e8daa84e556bbacdef66d4f3757f1260387b28d904d5e1c91949ef7c764ab8b3ca3f4f7980a7d2f3c8dfb6b0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9fb017e873ffc23fbc940d0920f5564e9fba64d9ab3767d1257e3a79d9d0758f9f2dbeba802d7e4e26c192b5b48703ff7e38611fee5ab1997f087652ee28b06a"} build_url:https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/PghxcfC5TIm3YHlLbgpzpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d3645dce17825a5740e23a87cec62d920ee85301d3cadfe94b6e0494d92a236264e16e64ee48b357ae9482226e6fc25ca8d6ed4209b7ed3ebc0fae4425b2104", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bd74b286f9114075c044c99a56711738e7ae247e8daa84e556bbacdef66d4f3757f1260387b28d904d5e1c91949ef7c764ab8b3ca3f4f7980a7d2f3c8dfb6b0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9fb017e873ffc23fbc940d0920f5564e9fba64d9ab3767d1257e3a79d9d0758f9f2dbeba802d7e4e26c192b5b48703ff7e38611fee5ab1997f087652ee28b06a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 23:01:01.943530) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 23:01:01.943912) ========= 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=6dbc10da6d83fee962c624be000001a8-1485326431.325988-109146425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004789 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 23:01:02.026514) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 23:01:02.029894) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 23:01:02.030227) ========= ========= Total master_lag: 0.18 =========