builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1480042461.26 results: success (0) buildid: 20161124173718 builduid: 9c5affca91414a84a8e80688aa0114a6 revision: 8ecafae107fbb8856948513301e2a726256b19d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 18:54:21.257854) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 18:54:21.258238) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 18:54:21.258797) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 18:54:21.352546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 18:54:21.352836) ========= 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=4300f881736b422476174874000001bc-1480042190.923026-1534513708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-24 18:54:21-- 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% 35.9M=0s 2016-11-24 18:54:21 (35.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128149 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 18:54:21.617470) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 18:54:21.617774) ========= 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=4300f881736b422476174874000001bc-1480042190.923026-1534513708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014006 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 18:54:21.672474) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-24 18:54:21.672796) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 8ecafae107fbb8856948513301e2a726256b19d8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 8ecafae107fbb8856948513301e2a726256b19d8 --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=4300f881736b422476174874000001bc-1480042190.923026-1534513708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-24 18:54:22,037 truncating revision to first 12 chars 2016-11-24 18:54:22,037 Setting DEBUG logging. 2016-11-24 18:54:22,037 attempt 1/10 2016-11-24 18:54:22,037 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/8ecafae107fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-24 18:54:22,721 unpacking tar archive at: graphics-8ecafae107fb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.053526 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-24 18:54:22.753027) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 18:54:22.753682) ========= script_repo_revision: 8ecafae107fbb8856948513301e2a726256b19d8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 18:54:22.754317) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 18:54:22.754717) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 18:54:22.765236) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-11-24 18:54:22.765689) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=4300f881736b422476174874000001bc-1480042190.923026-1534513708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:54:23 INFO - MultiFileLogger online at 20161124 18:54:23 in /builds/slave/test 18:54:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 18:54:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:54:23 INFO - {'append_to_log': False, 18:54:23 INFO - 'base_work_dir': '/builds/slave/test', 18:54:23 INFO - 'blob_upload_branch': 'Graphics', 18:54:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:54:23 INFO - 'branch': 'Graphics', 18:54:23 INFO - 'buildbot_json_path': 'buildprops.json', 18:54:23 INFO - 'config_files': ('talos/linux_config.py',), 18:54:23 INFO - 'default_actions': ('clobber', 18:54:23 INFO - 'read-buildbot-config', 18:54:23 INFO - 'download-and-extract', 18:54:23 INFO - 'populate-webroot', 18:54:23 INFO - 'create-virtualenv', 18:54:23 INFO - 'install', 18:54:23 INFO - 'run-tests'), 18:54:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:54:23 INFO - 'download_minidump_stackwalk': True, 18:54:23 INFO - 'download_symbols': 'ondemand', 18:54:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:54:23 INFO - 'tooltool.py': '/tools/tooltool.py', 18:54:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:54:23 INFO - '/tools/misc-python/virtualenv.py')}, 18:54:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:54:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:54:23 INFO - 'installer_path': 'installer.exe', 18:54:23 INFO - 'log_level': 'info', 18:54:23 INFO - 'log_name': 'talos', 18:54:23 INFO - 'log_to_console': True, 18:54:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:54:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:54:23 INFO - 'opt_config_files': (), 18:54:23 INFO - 'pip_index': False, 18:54:23 INFO - 'sps_profile': False, 18:54:23 INFO - 'sps_profile_interval': 0, 18:54:23 INFO - 'suite': 'dromaeojs', 18:54:23 INFO - 'system_bits': '32', 18:54:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:54:23 INFO - 'title': 'talos-linux64-ix-045', 18:54:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:54:23 INFO - 'use_talos_json': True, 18:54:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:54:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:54:23 INFO - 'work_dir': 'build'} 18:54:23 INFO - [mozharness: 2016-11-25 02:54:23.219487Z] Running clobber step. 18:54:23 INFO - Running pre-action listener: _resource_record_pre_action 18:54:23 INFO - Running main action method: clobber 18:54:23 INFO - rmtree: /builds/slave/test/build 18:54:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:54:24 INFO - Running post-action listener: _resource_record_post_action 18:54:24 INFO - [mozharness: 2016-11-25 02:54:24.196457Z] Finished clobber step (success) 18:54:24 INFO - [mozharness: 2016-11-25 02:54:24.196556Z] Running read-buildbot-config step. 18:54:24 INFO - Running pre-action listener: _resource_record_pre_action 18:54:24 INFO - Running main action method: read_buildbot_config 18:54:24 INFO - Using buildbot properties: 18:54:24 INFO - { 18:54:24 INFO - "project": "", 18:54:24 INFO - "product": "firefox", 18:54:24 INFO - "script_repo_revision": "default", 18:54:24 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 18:54:24 INFO - "repository": "", 18:54:24 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 18:54:24 INFO - "buildid": "20161124173718", 18:54:24 INFO - "pgo_build": "False", 18:54:24 INFO - "basedir": "/builds/slave/test", 18:54:24 INFO - "buildnumber": 23, 18:54:24 INFO - "slavename": "talos-linux64-ix-045", 18:54:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:54:24 INFO - "platform": "ubuntu64_hw", 18:54:24 INFO - "scheduler": "tests-graphics-linux64-talos", 18:54:24 INFO - "branch": "graphics", 18:54:24 INFO - "repo_path": "projects/graphics", 18:54:24 INFO - "revision": "8ecafae107fbb8856948513301e2a726256b19d8", 18:54:24 INFO - "stage_platform": "linux64", 18:54:24 INFO - "builduid": "9c5affca91414a84a8e80688aa0114a6", 18:54:24 INFO - "slavebuilddir": "test" 18:54:24 INFO - } 18:54:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 18:54:24 INFO - Running post-action listener: _resource_record_post_action 18:54:24 INFO - [mozharness: 2016-11-25 02:54:24.198943Z] Finished read-buildbot-config step (success) 18:54:24 INFO - [mozharness: 2016-11-25 02:54:24.199032Z] Running download-and-extract step. 18:54:24 INFO - Running pre-action listener: _resource_record_pre_action 18:54:24 INFO - Running main action method: download_and_extract 18:54:24 INFO - mkdir: /builds/slave/test/build/tests 18:54:24 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')]} 18:54:24 INFO - trying https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 18:54:24 INFO - Downloading https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 18:54:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:54:24 INFO - Downloaded 1361 bytes. 18:54:24 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 18:54:24 INFO - Using the following test package requirements: 18:54:24 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 18:54:24 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:24 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:54:24 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:24 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:54:24 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:24 INFO - u'jsshell-linux-x86_64.zip'], 18:54:24 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:24 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:54:24 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 18:54:24 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:24 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:54:24 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:24 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:54:24 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:24 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:54:24 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:24 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:54:24 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:54:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 18:54:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:54:24 INFO - Fetch https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:54:25 INFO - Http code: 200 18:54:25 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 18:54:25 INFO - x-amz-cf-id: 1THHP5kKhCtDH1S6G_WZpBEJKbVNu-t6qAXdLq2vPRah3KfxvJ5SDA== 18:54:25 INFO - x-amz-version-id: r7rKvzosaE916pm4ozvR1YtgB4EYmMwl 18:54:25 INFO - Expected file size: 20202013 18:54:25 INFO - Obtained file size: 20202013 18:54:29 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:54:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 18:54:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:54:29 INFO - Fetch https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:54:30 INFO - Http code: 200 18:54:30 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 18:54:30 INFO - x-amz-cf-id: D46FjqmoGbtdfGGJEEm2Nj4pxnCNZwLwe6FkB1fU5U-ZBbrGQPvC8Q== 18:54:30 INFO - x-amz-version-id: r7rKvzosaE916pm4ozvR1YtgB4EYmMwl 18:54:30 INFO - Expected file size: 20202013 18:54:30 INFO - Obtained file size: 20202013 18:54:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 18:54:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:54:34 INFO - Fetch https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:54:35 INFO - Http code: 200 18:54:35 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 18:54:35 INFO - x-amz-cf-id: IAxIlWGQwhBRDUmSWnnJNpYWILfOi4eFCEX_gq2C-nOfa_t4UVAwMQ== 18:54:35 INFO - x-amz-version-id: 0lmlAktHh7VgvkV21W6aBRmD_ABmGzqP 18:54:35 INFO - Expected file size: 14409506 18:54:35 INFO - Obtained file size: 14409506 18:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:35 INFO - trying https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 18:54:35 INFO - Downloading https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 18:54:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:54:37 INFO - Downloaded 55604232 bytes. 18:54:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 18:54:37 INFO - mkdir: /builds/slave/test/properties 18:54:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:54:37 INFO - Writing to file /builds/slave/test/properties/build_url 18:54:37 INFO - Contents: 18:54:37 INFO - build_url:https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 18:54:38 INFO - Running post-action listener: _resource_record_post_action 18:54:38 INFO - Running post-action listener: set_extra_try_arguments 18:54:38 INFO - [mozharness: 2016-11-25 02:54:38.031677Z] Finished download-and-extract step (success) 18:54:38 INFO - [mozharness: 2016-11-25 02:54:38.031940Z] Running populate-webroot step. 18:54:38 INFO - Running pre-action listener: _resource_record_pre_action 18:54:38 INFO - Running main action method: populate_webroot 18:54:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:54:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:54:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:54:38 INFO - '--tppagecycles', 18:54:38 INFO - '7'], 18:54:38 INFO - 'tests': ['tsvgm']}}, 18:54:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:54:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:54:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:54:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:54:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:54:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:54:38 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:54:38 INFO - 'talos_options': ['--disable-e10s'], 18:54:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:54:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:54:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:54:38 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:54:38 INFO - 'talos_options': ['--disable-e10s'], 18:54:38 INFO - 'tests': ['damp', 'tps']}, 18:54:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:54:38 INFO - 'tests': ['damp', 'tps']}, 18:54:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:54:38 INFO - 'tests': ['dromaeo_dom']}, 18:54:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:54:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:54:38 INFO - 'tests': ['basic_compositor_video']}, 18:54:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:54:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:54:38 INFO - 'tests': ['a11yr', 18:54:38 INFO - 'ts_paint', 18:54:38 INFO - 'tpaint', 18:54:38 INFO - 'sessionrestore', 18:54:38 INFO - 'sessionrestore_no_auto_restore', 18:54:38 INFO - 'tabpaint']}, 18:54:38 INFO - 'other-e10s': {'tests': ['a11yr', 18:54:38 INFO - 'ts_paint', 18:54:38 INFO - 'tpaint', 18:54:38 INFO - 'sessionrestore', 18:54:38 INFO - 'sessionrestore_no_auto_restore', 18:54:38 INFO - 'tabpaint']}, 18:54:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:54:38 INFO - 'ts_paint', 18:54:38 INFO - 'tpaint', 18:54:38 INFO - 'sessionrestore', 18:54:38 INFO - 'sessionrestore_no_auto_restore', 18:54:38 INFO - 'tabpaint']}, 18:54:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:54:38 INFO - 'ts_paint', 18:54:38 INFO - 'tpaint', 18:54:38 INFO - 'sessionrestore', 18:54:38 INFO - 'sessionrestore_no_auto_restore', 18:54:38 INFO - 'tabpaint']}, 18:54:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:54:38 INFO - 'tests': ['a11yr', 18:54:38 INFO - 'ts_paint', 18:54:38 INFO - 'tpaint', 18:54:38 INFO - 'sessionrestore', 18:54:38 INFO - 'sessionrestore_no_auto_restore', 18:54:38 INFO - 'tabpaint']}, 18:54:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:54:38 INFO - 'tests': ['a11yr', 18:54:38 INFO - 'ts_paint', 18:54:38 INFO - 'tpaint', 18:54:38 INFO - 'sessionrestore', 18:54:38 INFO - 'sessionrestore_no_auto_restore', 18:54:38 INFO - 'tabpaint']}, 18:54:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:54:38 INFO - 'tests': ['tsvgx', 18:54:38 INFO - 'tsvgr_opacity', 18:54:38 INFO - 'tart', 18:54:38 INFO - 'tscrollx', 18:54:38 INFO - 'cart']}, 18:54:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:54:38 INFO - 'tsvgr_opacity', 18:54:38 INFO - 'tart', 18:54:38 INFO - 'tscrollx', 18:54:38 INFO - 'cart']}, 18:54:38 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:54:38 INFO - 'talos_options': ['--disable-e10s'], 18:54:38 INFO - 'tests': ['tp5o']}, 18:54:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:54:38 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:54:38 INFO - 'talos_options': ['--disable-e10s', 18:54:38 INFO - '--xperf_path', 18:54:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:54:38 INFO - 'tests': ['tp5n']}, 18:54:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:54:38 INFO - 'talos_options': ['--xperf_path', 18:54:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:54:38 INFO - 'tests': ['tp5n']}}, 18:54:38 INFO - 'talos.zip': {'path': '', 18:54:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:54:38 INFO - Running post-action listener: _resource_record_post_action 18:54:38 INFO - [mozharness: 2016-11-25 02:54:38.047221Z] Finished populate-webroot step (success) 18:54:38 INFO - [mozharness: 2016-11-25 02:54:38.047308Z] Running create-virtualenv step. 18:54:38 INFO - Running pre-action listener: _resource_record_pre_action 18:54:38 INFO - Running main action method: create_virtualenv 18:54:38 INFO - Creating virtualenv /builds/slave/test/build/venv 18:54:38 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 18:54:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:54:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:54:38 INFO - Using real prefix '/usr' 18:54:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:54:38 INFO - Installing distribute.............................................................................................................................................................................................done. 18:54:40 INFO - Installing pip.................done. 18:54:40 INFO - Return code: 0 18:54:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:54:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:54:40 INFO - Reading from file tmpfile_stdout 18:54:40 INFO - Output received: 18:54:40 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) 18:54:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92b5aa7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a7130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535fc0>, '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 0x1536ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537350>, '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': '4300f881736b422476174874000001bc-1480042190.923026-1534513708', '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 18:54:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:54:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:54:40 INFO - Using env: {'DISPLAY': ':0', 18:54:40 INFO - 'HOME': '/home/cltbld', 18:54:40 INFO - 'LANG': 'en_US.UTF-8', 18:54:40 INFO - 'LANGUAGE': 'en_US:en', 18:54:40 INFO - 'LOGNAME': 'cltbld', 18:54:40 INFO - 'MAIL': '/var/mail/cltbld', 18:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:40 INFO - 'MOZ_NO_REMOTE': '1', 18:54:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:40 INFO - 'NO_EM_RESTART': '1', 18:54:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:40 INFO - 'PWD': '/builds/slave/test', 18:54:40 INFO - 'SHELL': '/bin/bash', 18:54:40 INFO - 'SHLVL': '1', 18:54:40 INFO - 'TERM': 'linux', 18:54:40 INFO - 'TMOUT': '86400', 18:54:40 INFO - 'USER': 'cltbld', 18:54:40 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480042190.923026-1534513708', 18:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:40 INFO - '_': '/tools/buildbot/bin/python'} 18:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:41 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 18:54:41 INFO - Cleaning up... 18:54:41 INFO - Return code: 0 18:54:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:54:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f92b5aa7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a7130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535fc0>, '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 0x1536ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537350>, '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': '4300f881736b422476174874000001bc-1480042190.923026-1534513708', '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 18:54:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:54:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:54:41 INFO - Using env: {'DISPLAY': ':0', 18:54:41 INFO - 'HOME': '/home/cltbld', 18:54:41 INFO - 'LANG': 'en_US.UTF-8', 18:54:41 INFO - 'LANGUAGE': 'en_US:en', 18:54:41 INFO - 'LOGNAME': 'cltbld', 18:54:41 INFO - 'MAIL': '/var/mail/cltbld', 18:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:41 INFO - 'MOZ_NO_REMOTE': '1', 18:54:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:41 INFO - 'NO_EM_RESTART': '1', 18:54:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:41 INFO - 'PWD': '/builds/slave/test', 18:54:41 INFO - 'SHELL': '/bin/bash', 18:54:41 INFO - 'SHLVL': '1', 18:54:41 INFO - 'TERM': 'linux', 18:54:41 INFO - 'TMOUT': '86400', 18:54:41 INFO - 'USER': 'cltbld', 18:54:41 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480042190.923026-1534513708', 18:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:41 INFO - '_': '/tools/buildbot/bin/python'} 18:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:41 INFO - Downloading/unpacking psutil>=3.1.1 18:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:54:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:54:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:54:43 INFO - Installing collected packages: psutil 18:54:43 INFO - Running setup.py install for psutil 18:54:43 INFO - building 'psutil._psutil_linux' extension 18:54:43 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 18:54:43 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 18:54:43 INFO - building 'psutil._psutil_posix' extension 18:54:43 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 18:54:43 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 18:54:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:54:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:54:43 INFO - Successfully installed psutil 18:54:43 INFO - Cleaning up... 18:54:43 INFO - Return code: 0 18:54:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:54:43 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')]} 18:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:43 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')]} 18:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:43 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 0x7f92b5aa7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a7130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535fc0>, '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 0x1536ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537350>, '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': '4300f881736b422476174874000001bc-1480042190.923026-1534513708', '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 18:54:43 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 18:54:43 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 18:54:43 INFO - Using env: {'DISPLAY': ':0', 18:54:43 INFO - 'HOME': '/home/cltbld', 18:54:43 INFO - 'LANG': 'en_US.UTF-8', 18:54:43 INFO - 'LANGUAGE': 'en_US:en', 18:54:43 INFO - 'LOGNAME': 'cltbld', 18:54:43 INFO - 'MAIL': '/var/mail/cltbld', 18:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:43 INFO - 'MOZ_NO_REMOTE': '1', 18:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:43 INFO - 'NO_EM_RESTART': '1', 18:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:43 INFO - 'PWD': '/builds/slave/test', 18:54:43 INFO - 'SHELL': '/bin/bash', 18:54:43 INFO - 'SHLVL': '1', 18:54:43 INFO - 'TERM': 'linux', 18:54:43 INFO - 'TMOUT': '86400', 18:54:43 INFO - 'USER': 'cltbld', 18:54:43 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480042190.923026-1534513708', 18:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:43 INFO - '_': '/tools/buildbot/bin/python'} 18:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:54:44 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 18:54:44 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 18:54:44 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 18:54:44 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 18:54:44 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 18:54:44 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 18:54:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:54:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:54:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:54:46 INFO - Installing collected packages: mozsystemmonitor 18:54:46 INFO - Running setup.py install for mozsystemmonitor 18:54:46 INFO - Successfully installed mozsystemmonitor 18:54:46 INFO - Cleaning up... 18:54:46 INFO - Return code: 0 18:54:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:54:46 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')]} 18:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:46 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')]} 18:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:46 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 0x7f92b5aa7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a7130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535fc0>, '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 0x1536ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537350>, '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': '4300f881736b422476174874000001bc-1480042190.923026-1534513708', '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 18:54:46 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 18:54:46 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 18:54:46 INFO - Using env: {'DISPLAY': ':0', 18:54:46 INFO - 'HOME': '/home/cltbld', 18:54:46 INFO - 'LANG': 'en_US.UTF-8', 18:54:46 INFO - 'LANGUAGE': 'en_US:en', 18:54:46 INFO - 'LOGNAME': 'cltbld', 18:54:46 INFO - 'MAIL': '/var/mail/cltbld', 18:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:46 INFO - 'MOZ_NO_REMOTE': '1', 18:54:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:46 INFO - 'NO_EM_RESTART': '1', 18:54:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:46 INFO - 'PWD': '/builds/slave/test', 18:54:46 INFO - 'SHELL': '/bin/bash', 18:54:46 INFO - 'SHLVL': '1', 18:54:46 INFO - 'TERM': 'linux', 18:54:46 INFO - 'TMOUT': '86400', 18:54:46 INFO - 'USER': 'cltbld', 18:54:46 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480042190.923026-1534513708', 18:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:46 INFO - '_': '/tools/buildbot/bin/python'} 18:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:46 INFO - Downloading/unpacking jsonschema==2.5.1 18:54:46 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 18:54:46 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 18:54:46 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 18:54:46 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 18:54:46 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 18:54:46 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 18:54:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:54:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:54:48 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 18:54:48 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 18:54:48 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 18:54:48 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 18:54:48 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 18:54:48 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 18:54:48 INFO - Downloading functools32-3.2.3-2.tar.gz 18:54:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:54:48 INFO - warning: no files found matching '*.txt' 18:54:48 INFO - no previously-included directories found matching 'build' 18:54:48 INFO - no previously-included directories found matching 'dist' 18:54:48 INFO - no previously-included directories found matching '.git*' 18:54:48 INFO - Installing collected packages: jsonschema, functools32 18:54:48 INFO - Running setup.py install for functools32 18:54:48 INFO - warning: no files found matching '*.txt' 18:54:48 INFO - no previously-included directories found matching 'build' 18:54:48 INFO - no previously-included directories found matching 'dist' 18:54:48 INFO - no previously-included directories found matching '.git*' 18:54:48 INFO - Successfully installed jsonschema functools32 18:54:48 INFO - Cleaning up... 18:54:49 INFO - Return code: 0 18:54:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:54: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')]} 18:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54: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')]} 18:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54: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', '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 0x7f92b5aa7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a7130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535fc0>, '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 0x1536ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537350>, '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': '4300f881736b422476174874000001bc-1480042190.923026-1534513708', '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 18:54: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:54: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 functools32==3.2.3-2 18:54:49 INFO - Using env: {'DISPLAY': ':0', 18:54:49 INFO - 'HOME': '/home/cltbld', 18:54:49 INFO - 'LANG': 'en_US.UTF-8', 18:54:49 INFO - 'LANGUAGE': 'en_US:en', 18:54:49 INFO - 'LOGNAME': 'cltbld', 18:54:49 INFO - 'MAIL': '/var/mail/cltbld', 18:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:49 INFO - 'MOZ_NO_REMOTE': '1', 18:54:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:49 INFO - 'NO_EM_RESTART': '1', 18:54:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:49 INFO - 'PWD': '/builds/slave/test', 18:54:49 INFO - 'SHELL': '/bin/bash', 18:54:49 INFO - 'SHLVL': '1', 18:54:49 INFO - 'TERM': 'linux', 18:54:49 INFO - 'TMOUT': '86400', 18:54:49 INFO - 'USER': 'cltbld', 18:54:49 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480042190.923026-1534513708', 18:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:49 INFO - '_': '/tools/buildbot/bin/python'} 18:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:54:49 INFO - Cleaning up... 18:54:49 INFO - Return code: 0 18:54:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:54: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')]} 18:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54: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')]} 18:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54: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', '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 0x7f92b5aa7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a7130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535fc0>, '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 0x1536ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537350>, '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': '4300f881736b422476174874000001bc-1480042190.923026-1534513708', '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 18:54: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:54: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 blobuploader==1.2.4 18:54:49 INFO - Using env: {'DISPLAY': ':0', 18:54:49 INFO - 'HOME': '/home/cltbld', 18:54:49 INFO - 'LANG': 'en_US.UTF-8', 18:54:49 INFO - 'LANGUAGE': 'en_US:en', 18:54:49 INFO - 'LOGNAME': 'cltbld', 18:54:49 INFO - 'MAIL': '/var/mail/cltbld', 18:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:49 INFO - 'MOZ_NO_REMOTE': '1', 18:54:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:49 INFO - 'NO_EM_RESTART': '1', 18:54:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:49 INFO - 'PWD': '/builds/slave/test', 18:54:49 INFO - 'SHELL': '/bin/bash', 18:54:49 INFO - 'SHLVL': '1', 18:54:49 INFO - 'TERM': 'linux', 18:54:49 INFO - 'TMOUT': '86400', 18:54:49 INFO - 'USER': 'cltbld', 18:54:49 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480042190.923026-1534513708', 18:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:49 INFO - '_': '/tools/buildbot/bin/python'} 18:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:49 INFO - Downloading/unpacking blobuploader==1.2.4 18:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:51 INFO - Downloading blobuploader-1.2.4.tar.gz 18:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:54:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:54:51 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 18:54:51 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 18:54:51 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 18:54:51 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 18:54:51 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 18:54:51 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 18:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:54:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:54:51 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 18:54:51 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 18:54:51 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 18:54:51 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 18:54:51 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 18:54:51 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 18:54:52 INFO - Downloading docopt-0.6.1.tar.gz 18:54:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:54:52 INFO - Installing collected packages: blobuploader, requests, docopt 18:54:52 INFO - Running setup.py install for blobuploader 18:54:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:54:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:54:52 INFO - Running setup.py install for requests 18:54:52 INFO - Running setup.py install for docopt 18:54:52 INFO - Successfully installed blobuploader requests docopt 18:54:52 INFO - Cleaning up... 18:54:52 INFO - Return code: 0 18:54:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:54: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')]} 18:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54: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')]} 18:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:52 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 0x7f92b5aa7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a7130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535fc0>, '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 0x1536ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537350>, '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': '4300f881736b422476174874000001bc-1480042190.923026-1534513708', '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 18:54:52 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 18:54:52 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 18:54:52 INFO - Using env: {'DISPLAY': ':0', 18:54:52 INFO - 'HOME': '/home/cltbld', 18:54:52 INFO - 'LANG': 'en_US.UTF-8', 18:54:52 INFO - 'LANGUAGE': 'en_US:en', 18:54:52 INFO - 'LOGNAME': 'cltbld', 18:54:52 INFO - 'MAIL': '/var/mail/cltbld', 18:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:52 INFO - 'MOZ_NO_REMOTE': '1', 18:54:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:52 INFO - 'NO_EM_RESTART': '1', 18:54:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:52 INFO - 'PWD': '/builds/slave/test', 18:54:52 INFO - 'SHELL': '/bin/bash', 18:54:52 INFO - 'SHLVL': '1', 18:54:52 INFO - 'TERM': 'linux', 18:54:52 INFO - 'TMOUT': '86400', 18:54:52 INFO - 'USER': 'cltbld', 18:54:52 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480042190.923026-1534513708', 18:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:52 INFO - '_': '/tools/buildbot/bin/python'} 18:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:54:53 INFO - Running setup.py (path:/tmp/pip-YXXMxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:54:53 INFO - Running setup.py (path:/tmp/pip-SWWxwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:54:53 INFO - Running setup.py (path:/tmp/pip-UkTYOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:54:53 INFO - Running setup.py (path:/tmp/pip-ZnRq9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:54:53 INFO - Running setup.py (path:/tmp/pip-UEX5Tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:54:53 INFO - Running setup.py (path:/tmp/pip-BIu8pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:54:53 INFO - Running setup.py (path:/tmp/pip-aAwKL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:54:53 INFO - Running setup.py (path:/tmp/pip-KIUDto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:54:53 INFO - Running setup.py (path:/tmp/pip-Nwt1ZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:54:53 INFO - Running setup.py (path:/tmp/pip-rhsmyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:54:53 INFO - Running setup.py (path:/tmp/pip-fvU0P9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:54:53 INFO - Running setup.py (path:/tmp/pip-maDPx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:54:53 INFO - Running setup.py (path:/tmp/pip-mO0l1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:54:53 INFO - Running setup.py (path:/tmp/pip-ns1GIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:54:54 INFO - Running setup.py (path:/tmp/pip-WovAy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:54:54 INFO - Running setup.py (path:/tmp/pip-iukzKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:54:54 INFO - Running setup.py (path:/tmp/pip-lB7taU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:54:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:54:54 INFO - Running setup.py install for manifestparser 18:54:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:54:54 INFO - Running setup.py install for mozcrash 18:54:54 INFO - Running setup.py install for mozdebug 18:54:54 INFO - Running setup.py install for mozdevice 18:54:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:54:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:54:54 INFO - Running setup.py install for mozfile 18:54:54 INFO - Running setup.py install for mozhttpd 18:54:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:54:54 INFO - Running setup.py install for mozinfo 18:54:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:54:54 INFO - Running setup.py install for mozInstall 18:54:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:54:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:54:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:54:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:54:55 INFO - Running setup.py install for mozleak 18:54:55 INFO - Running setup.py install for mozlog 18:54:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:54:55 INFO - Running setup.py install for moznetwork 18:54:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:54:55 INFO - Running setup.py install for mozprocess 18:54:55 INFO - Running setup.py install for mozprofile 18:54:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:54:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:54:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:54:55 INFO - Running setup.py install for mozrunner 18:54:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:54:55 INFO - Running setup.py install for mozscreenshot 18:54:55 INFO - Running setup.py install for moztest 18:54:55 INFO - Running setup.py install for mozversion 18:54:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:54:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:54:56 INFO - Cleaning up... 18:54:56 INFO - Return code: 0 18:54:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:54:56 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')]} 18:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:56 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')]} 18:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:56 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 0x7f92b5aa7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a7130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535fc0>, '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 0x1536ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537350>, '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': '4300f881736b422476174874000001bc-1480042190.923026-1534513708', '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 18:54:56 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 18:54:56 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 18:54:56 INFO - Using env: {'DISPLAY': ':0', 18:54:56 INFO - 'HOME': '/home/cltbld', 18:54:56 INFO - 'LANG': 'en_US.UTF-8', 18:54:56 INFO - 'LANGUAGE': 'en_US:en', 18:54:56 INFO - 'LOGNAME': 'cltbld', 18:54:56 INFO - 'MAIL': '/var/mail/cltbld', 18:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:56 INFO - 'MOZ_NO_REMOTE': '1', 18:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:56 INFO - 'NO_EM_RESTART': '1', 18:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:56 INFO - 'PWD': '/builds/slave/test', 18:54:56 INFO - 'SHELL': '/bin/bash', 18:54:56 INFO - 'SHLVL': '1', 18:54:56 INFO - 'TERM': 'linux', 18:54:56 INFO - 'TMOUT': '86400', 18:54:56 INFO - 'USER': 'cltbld', 18:54:56 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480042190.923026-1534513708', 18:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:56 INFO - '_': '/tools/buildbot/bin/python'} 18:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:54:56 INFO - Running setup.py (path:/tmp/pip-lo0rR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:54:56 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)) 18:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:54:56 INFO - Running setup.py (path:/tmp/pip-GChAfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:54:56 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)) 18:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:54:56 INFO - Running setup.py (path:/tmp/pip-Nti6oC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:54:56 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)) 18:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:54:56 INFO - Running setup.py (path:/tmp/pip-587yLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 18:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:54:56 INFO - Running setup.py (path:/tmp/pip-oxhElw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:54:56 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)) 18:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:54:56 INFO - Running setup.py (path:/tmp/pip-ifhtnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:54:56 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)) 18:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:54:56 INFO - Running setup.py (path:/tmp/pip-bwuuv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:54:56 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)) 18:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:54:56 INFO - Running setup.py (path:/tmp/pip-hgb52f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:54:56 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)) 18:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:54:56 INFO - Running setup.py (path:/tmp/pip-3ZjuAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:54:56 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)) 18:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:54:56 INFO - Running setup.py (path:/tmp/pip-yumDfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:54:57 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)) 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:54:57 INFO - Running setup.py (path:/tmp/pip-tCMYLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:54:57 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)) 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:54:57 INFO - Running setup.py (path:/tmp/pip-DGk0Qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:54:57 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)) 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:54:57 INFO - Running setup.py (path:/tmp/pip-oBC7IG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:54:57 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)) 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:54:57 INFO - Running setup.py (path:/tmp/pip-7XBAAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:54:57 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)) 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:54:57 INFO - Running setup.py (path:/tmp/pip-bT5u8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:54:57 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)) 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:54:57 INFO - Running setup.py (path:/tmp/pip-DCVJ2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:54:57 INFO - Running setup.py (path:/tmp/pip-qhV1Ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:54:57 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)) 18:54:57 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)) 18:54:57 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)) 18:54:57 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)) 18:54:57 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:54:57 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:54:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54:59 INFO - Downloading blessings-1.6.tar.gz 18:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:54:59 INFO - Installing collected packages: blessings 18:54:59 INFO - Running setup.py install for blessings 18:54:59 INFO - Successfully installed blessings 18:54:59 INFO - Cleaning up... 18:54:59 INFO - Return code: 0 18:54:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:54:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:54:59 INFO - Reading from file tmpfile_stdout 18:54:59 INFO - Current package versions: 18:54:59 INFO - argparse == 1.2.1 18:54:59 INFO - blessings == 1.6 18:54:59 INFO - blobuploader == 1.2.4 18:54:59 INFO - docopt == 0.6.1 18:54:59 INFO - functools32 == 3.2.3-2 18:54:59 INFO - jsonschema == 2.5.1 18:54:59 INFO - manifestparser == 1.1 18:54:59 INFO - mozInstall == 1.12 18:54:59 INFO - mozcrash == 1.0 18:54:59 INFO - mozdebug == 0.1 18:54:59 INFO - mozdevice == 0.49 18:54:59 INFO - mozfile == 1.2 18:54:59 INFO - mozhttpd == 0.7 18:54:59 INFO - mozinfo == 0.9 18:54:59 INFO - mozleak == 0.1 18:54:59 INFO - mozlog == 3.4 18:54:59 INFO - moznetwork == 0.27 18:54:59 INFO - mozprocess == 0.23 18:54:59 INFO - mozprofile == 0.28 18:54:59 INFO - mozrunner == 6.13 18:54:59 INFO - mozscreenshot == 0.1 18:54:59 INFO - mozsystemmonitor == 0.3 18:54:59 INFO - moztest == 0.7 18:54:59 INFO - mozversion == 1.4 18:54:59 INFO - psutil == 3.1.1 18:54:59 INFO - requests == 1.2.3 18:54:59 INFO - wsgiref == 0.1.2 18:54:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:59 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 0x7f92b5aa7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a7130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535fc0>, '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 0x1536ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537350>, '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': '4300f881736b422476174874000001bc-1480042190.923026-1534513708', '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 18:54:59 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 18:54:59 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 18:54:59 INFO - Using env: {'DISPLAY': ':0', 18:54:59 INFO - 'HOME': '/home/cltbld', 18:54:59 INFO - 'LANG': 'en_US.UTF-8', 18:54:59 INFO - 'LANGUAGE': 'en_US:en', 18:54:59 INFO - 'LOGNAME': 'cltbld', 18:54:59 INFO - 'MAIL': '/var/mail/cltbld', 18:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:59 INFO - 'MOZ_NO_REMOTE': '1', 18:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:59 INFO - 'NO_EM_RESTART': '1', 18:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:59 INFO - 'PWD': '/builds/slave/test', 18:54:59 INFO - 'SHELL': '/bin/bash', 18:54:59 INFO - 'SHLVL': '1', 18:54:59 INFO - 'TERM': 'linux', 18:54:59 INFO - 'TMOUT': '86400', 18:54:59 INFO - 'USER': 'cltbld', 18:54:59 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480042190.923026-1534513708', 18:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:59 INFO - '_': '/tools/buildbot/bin/python'} 18:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:00 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)) 18:55:00 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)) 18:55:00 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)) 18:55:00 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)) 18:55:00 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)) 18:55:00 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)) 18:55:00 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)) 18:55:00 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)) 18:55:00 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)) 18:55:00 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)) 18:55:00 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)) 18:55:00 INFO - Cleaning up... 18:55:00 INFO - Return code: 0 18:55:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:00 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 0x7f92b5aa7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a7130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535fc0>, '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 0x1536ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537350>, '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': '4300f881736b422476174874000001bc-1480042190.923026-1534513708', '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 18:55:00 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 18:55:00 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 18:55:00 INFO - Using env: {'DISPLAY': ':0', 18:55:00 INFO - 'HOME': '/home/cltbld', 18:55:00 INFO - 'LANG': 'en_US.UTF-8', 18:55:00 INFO - 'LANGUAGE': 'en_US:en', 18:55:00 INFO - 'LOGNAME': 'cltbld', 18:55:00 INFO - 'MAIL': '/var/mail/cltbld', 18:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:00 INFO - 'MOZ_NO_REMOTE': '1', 18:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:00 INFO - 'NO_EM_RESTART': '1', 18:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:00 INFO - 'PWD': '/builds/slave/test', 18:55:00 INFO - 'SHELL': '/bin/bash', 18:55:00 INFO - 'SHLVL': '1', 18:55:00 INFO - 'TERM': 'linux', 18:55:00 INFO - 'TMOUT': '86400', 18:55:00 INFO - 'USER': 'cltbld', 18:55:00 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480042190.923026-1534513708', 18:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:00 INFO - '_': '/tools/buildbot/bin/python'} 18:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:55:00 INFO - Cleaning up... 18:55:00 INFO - Return code: 0 18:55:00 INFO - Running post-action listener: _resource_record_post_action 18:55:00 INFO - Running post-action listener: _start_resource_monitoring 18:55:00 INFO - Starting resource monitoring. 18:55:00 INFO - [mozharness: 2016-11-25 02:55:00.418715Z] Finished create-virtualenv step (success) 18:55:00 INFO - [mozharness: 2016-11-25 02:55:00.419231Z] Running install step. 18:55:00 INFO - Running pre-action listener: _resource_record_pre_action 18:55:00 INFO - Running main action method: install 18:55:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:55:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:55:00 INFO - Reading from file tmpfile_stdout 18:55:00 INFO - Detecting whether we're running mozinstall >=1.0... 18:55:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:55:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:55:00 INFO - Reading from file tmpfile_stdout 18:55:00 INFO - Output received: 18:55:00 INFO - Usage: mozinstall [options] installer 18:55:00 INFO - Options: 18:55:00 INFO - -h, --help show this help message and exit 18:55:00 INFO - -d DEST, --destination=DEST 18:55:00 INFO - Directory to install application into. [default: 18:55:00 INFO - "/builds/slave/test"] 18:55:00 INFO - --app=APP Application being installed. [default: firefox] 18:55:00 INFO - mkdir: /builds/slave/test/build/application 18:55:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:55:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:55:16 INFO - Reading from file tmpfile_stdout 18:55:16 INFO - Output received: 18:55:16 INFO - /builds/slave/test/build/application/firefox/firefox 18:55:16 INFO - Running post-action listener: _resource_record_post_action 18:55:16 INFO - [mozharness: 2016-11-25 02:55:16.732823Z] Finished install step (success) 18:55:16 INFO - [mozharness: 2016-11-25 02:55:16.733077Z] Running run-tests step. 18:55:16 INFO - Running pre-action listener: _resource_record_pre_action 18:55:16 INFO - Running main action method: run_tests 18:55:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:55:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:55:16 INFO - Python 2.7.3 18:55:16 INFO - Return code: 0 18:55:16 INFO - grabbing minidump binary from tooltool 18:55:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:55:16 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 0x1535fc0>, '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 0x1536ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:55:16 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 18:55:16 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 18:55:16 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 18:55:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:55:16 INFO - Return code: 0 18:55:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:55:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:55:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:55:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:55:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:55:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 18:55:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 18:55:16 INFO - Using env: {'DISPLAY': ':0', 18:55:16 INFO - 'HOME': '/home/cltbld', 18:55:16 INFO - 'LANG': 'en_US.UTF-8', 18:55:16 INFO - 'LANGUAGE': 'en_US:en', 18:55:16 INFO - 'LOGNAME': 'cltbld', 18:55:16 INFO - 'MAIL': '/var/mail/cltbld', 18:55:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:55:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:55:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:16 INFO - 'MOZ_NO_REMOTE': '1', 18:55:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:55:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:16 INFO - 'NO_EM_RESTART': '1', 18:55:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:16 INFO - 'PWD': '/builds/slave/test', 18:55:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:55:16 INFO - 'SHELL': '/bin/bash', 18:55:16 INFO - 'SHLVL': '1', 18:55:16 INFO - 'TERM': 'linux', 18:55:16 INFO - 'TMOUT': '86400', 18:55:16 INFO - 'USER': 'cltbld', 18:55:16 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480042190.923026-1534513708', 18:55:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:16 INFO - '_': '/tools/buildbot/bin/python'} 18:55:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 18:55:17 INFO - mozversion application_buildid: 20161124173718 18:55:17 INFO - mozversion application_changeset: 8ecafae107fbb8856948513301e2a726256b19d8 18:55:17 INFO - mozversion application_display_name: Nightly 18:55:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:55:17 INFO - mozversion application_name: Firefox 18:55:17 INFO - mozversion application_remotingname: firefox 18:55:17 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 18:55:17 INFO - mozversion application_vendor: Mozilla 18:55:17 INFO - mozversion application_version: 53.0a1 18:55:17 INFO - mozversion platform_buildid: 20161124173718 18:55:17 INFO - mozversion platform_changeset: 8ecafae107fbb8856948513301e2a726256b19d8 18:55:17 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 18:55:17 INFO - mozversion platform_version: 53.0a1 18:55:17 INFO - using testdate: 1480042517 18:55:17 INFO - actual date: 1480042517 18:55:17 INFO - starting webserver on 'localhost:42330' 18:55:17 INFO - SUITE-START | Running 2 tests 18:55:17 INFO - TEST-START | dromaeo_css 18:55:17 INFO - operating with platform_type : linux_ 18:55:17 INFO - Initialising browser for dromaeo_css test... 18:55:17 INFO - TEST-INFO | started process 9664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFIwl6d/profile http://localhost:42330/getInfo.html) 18:55:21 INFO - PROCESS | 9664 | __metrics Screen width/height:1600/1200 18:55:21 INFO - PROCESS | 9664 | colorDepth:24 18:55:21 INFO - PROCESS | 9664 | Browser inner width/height: 1024/697 18:55:21 INFO - PROCESS | 9664 | __metrics 18:55:22 INFO - PROCESS | 9664 | 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" 18:55:22 INFO - PROCESS | 9664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:55:22 INFO - PROCESS | 9664 | console.error: PushService: 18:55:22 INFO - PROCESS | 9664 | stateChangeProcessEnqueue: Error transitioning state 18:55:22 INFO - PROCESS | 9664 | UnknownError 18:55:23 INFO - TEST-INFO | 9664: exit 0 18:55:23 INFO - Browser initialized. 18:55:23 INFO - Running cycle 1/1 for dromaeo_css test... 18:55:23 INFO - TEST-INFO | started process 9747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFIwl6d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:55:35 INFO - PROCESS | 9747 | RSS: Main: 174723072 18:55:35 INFO - PROCESS | 9747 | 18:56:27 INFO - PROCESS | 9747 | 1480042587252 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:58:41 INFO - PROCESS | 9747 | Cycle 1(1): loaded http://localhost:42330/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42330/tests/dromaeo/cssquery-ext.html) 18:58:42 INFO - PROCESS | 9747 | RSS: Main: 323088384 18:58:42 INFO - PROCESS | 9747 | 19:01:45 INFO - PROCESS | 9747 | Cycle 1(1): loaded http://localhost:42330/tests/dromaeo/cssquery-ext.html (next: http://localhost:42330/tests/dromaeo/cssquery-jquery.html) 19:01:46 INFO - PROCESS | 9747 | RSS: Main: 275607552 19:01:46 INFO - PROCESS | 9747 | 19:04:48 INFO - PROCESS | 9747 | Cycle 1(1): loaded http://localhost:42330/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42330/tests/dromaeo/cssquery-mootools.html) 19:04:49 INFO - PROCESS | 9747 | RSS: Main: 219848704 19:04:49 INFO - PROCESS | 9747 | 19:07:51 INFO - PROCESS | 9747 | Cycle 1(1): loaded http://localhost:42330/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42330/tests/dromaeo/cssquery-prototype.html) 19:07:52 INFO - PROCESS | 9747 | RSS: Main: 219897856 19:07:52 INFO - PROCESS | 9747 | 19:10:55 INFO - PROCESS | 9747 | Cycle 1(1): loaded http://localhost:42330/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42330/tests/dromaeo/cssquery-yui.html) 19:10:55 INFO - PROCESS | 9747 | RSS: Main: 219574272 19:10:55 INFO - PROCESS | 9747 | 19:13:59 INFO - PROCESS | 9747 | Cycle 1(1): loaded http://localhost:42330/tests/dromaeo/cssquery-yui.html (next: http://localhost:42330/tests/dromaeo/cssquery-dojo.html) 19:13:59 INFO - PROCESS | 9747 | RSS: Main: 307945472 19:13:59 INFO - PROCESS | 9747 | 19:13:59 INFO - PROCESS | 9747 | __start_tp_report 19:13:59 INFO - PROCESS | 9747 | _x_x_mozilla_page_load 19:13:59 INFO - PROCESS | 9747 | _x_x_mozilla_page_load_details 19:13:59 INFO - PROCESS | 9747 | |i|pagename|runs| 19:13:59 INFO - PROCESS | 9747 | |0;dojo.html;2528.469021505484;2569.1136557887544;2573.2151693733417;2584.457263974565;2594.416256342322;4454.866354009377;4516.36770852081;4599.58603725665;4599.9540004599985;4625.930611040832;4528.796204170812;4542.727436353821;4546.931796023054;4550.590446859782;4553.134904368176;4172.165566886627;4194.790260486979;4219.725717828332;4229.915401691965;4236.555161708023;4219.831206751726;4279.293916503773;4297.828086876521;4330.675199360045;4368.453943257093;4232.238197124517;4274.871753847389;4284.871453856389;4299.484061912575;4351.173277077361;4295.4201182840225;4300.763458009808;4304;4308.784560771949;4357.041450880801;4145.97927010366;4191.97904010481;4230.132822771325;4257.382679511485;4299.441072660566;4246.936295955563;4505.098980203972;4612.238980568202;4648.2562789953445;4652.790624421876;4931.186354251544;4933.481984391623;4952.356193694833;4958.281049247875;4985.700857948535;4988.426330971948;4996.650234483587;4997.375328083989;5003.199488081926;5033.546980771712;4459.44256967879;4544;4548.204064288736;4650.720956742606;4703.0593881223895;4979.228219625964;5025.497450254945;5045.974770126126;5065.569426598707;5117.795288188431;4863.756812159378;4868.391451068616;4868.878278043077;4872.4883887192045;4916.115099282163;4754.809807607726;4926.778294976734;4950.801967921315;4951.851444456672;4991.5258050485145;4781.115493633689;4801.4958429364415;4836.371271734652;4856.247281671276;4883.389576302962;4867.1969125093965;4867.367242258554;4871.634627402959;4873.171560834667;4909.091818013608;4273.722208056529;4283.293256612624;4288.2281189385585;4296.334068219431;4323.0705398339505;3647.0882279430143;3668.284684486553;3683.557973043198;3684.778913265213;3689.6679298863232;4266;4289.485261768607;4295.205387003414;4317.330813723815;4320.4599425071865;4968.8757781055765;4969.378827646544;4972.129877271463;4976.502349765067;5011.974940125276;4149.962509372657;4191.287481128215;4202.831886724558;4291.54938731435;4326.2212801696;4453.844115455943;4461.531539188403;4469.217886869785;4471.396361491222;4472.686911916199;4514.390557274857;4559.361689363492;4565.9954809941755;4567.611753001032;4573.908521829611;4910.189818679878;4916.2625606157935;4921.064997650435;4935.111679897653;4958.528939750718;4630.629549636088;4631.143238500888;4666.906661866811;4675.555822196886;4680.274557443602;4881.536254055859;4918.827841025547;4921.532454416824;4924.187509060965;4966.627502937366;4783.928241076456;4848.248521479177;4941.234108713155;4952.133376659142;5002.649814512949;4755.1916174251155;4764.404449443819;4764.4520880099235;4766.237402015661;4767.4994125617695;4714.080754252887;4731.69243999139;4762.380890484214;4762.904741905073;4776.044791041736;4725.692829966041;4729.05418916225;4730.1958667027375;4775.594074503567;4778.187708089564;4818.68678535894;4824.710517368969;4826.638002149923;4835.927461088017;4871.97688485422;4586.1057093866375;4630.421197350332;4642.0483800820075;4651.116287905287;4716.5990890774665 19:13:59 INFO - PROCESS | 9747 | |1;ext.html;546.811350084221;550.328599109087;557.0919401375758;567.892100500905;572.0675299262202;28815.711842881567;38440.423393649115;39804.60195398049;39878.60121398785;44359.55640443595;40261.59738402615;40848.79575602118;40850.59149408505;40865.18269634613;40870.795646021725;7392.519486233405;7475.962620186891;7592.924070759277;7621.733239336624;7626.237376262357;7371.778846634609;9501.762455938588;9767;9767.413955162678;10024.548895299693;9486.905130948671;9521.190698790611;9523.095305945924;9524.8571271431;9530.618775248982;9525.333226674102;9569.617215311378;9574.664886728931;9582.329236953416;9582.952085239598;9764.902350976541;9822.312438129335;9826.508674566243;9827.557759900821;9833.557489912972;37530.43704344437;37827.81086094579;37836.62163378359;37842.24315513702;37861.43207851885;2944.1903476543907;2949.5133303004977;2994.7005299470097;3007.9248018799485;3022.788404811664;27925.860370698018;27968.720312796817;28311.292217694518;28471.857640711663;28630.85684571564;3387.7120444762227;3445.913852153691;3448.189675426273;3449.275652113059;3466.843992020365;252604;253123.99999999817;253653;253798;254446;52940;53032.46967530275;53404.19893701598;53423;53429;49550.256746148836;49892;49960.75019624879;49978.50021499739;49994.75002624963;14452.349644266033;14850.851491485162;14885.106893586202;14890.92554537242;14897.18065506386;10098.798024039477;10541.156707463384;11043.116550675926;11074.778504430027;11090.223684342018;16401.917990409973;16666.33334666624;16685.33258669664;16697.749533757004;16733.83266167347;6198.2252218472695;6198.86139281947;6226.5641405101205;6244.250689917239;6559.114519539897;767.85794627994;810.6473683947502;840.878072679458;928;974.6907612602479;26838.463230735277;27952.72047279542;28410;28441.288967775556;28472.572911406347;918.5315489100607;924.9121333473444;935.5883411299006;999.8050380175796;1032.3496197395593;14103.506377276746;14869.405223791144;15013.474528391454;15253.847461525465;15271;347885;349452;351548;351552;351822;49131;49196;49254.50745492571;49290.75354623204;49401.75299123553;1012.427978192319;1076.7254350140663;1108.6563165418745;1137.38581166171;1168.0480408467072;25124.74875251224;27801.582976255777;29026.7097329024;31303.530447042856;32016.199595010312;46752.06495870132;47325;47383.52616473929;47440.76279618718;47520;323100;325659;326298;326803;327879;21836.344909652737;22679.659805103267;22689.773102269428;23824.16615418452;24391.756082438947;37648.62351376451;37813;38071.809640951615;38629;39712.014399279346;32647.510287345234;32675.673243268215;32676.83661581677;32870.835645822575;32896.506552402214;32315.676843232206;32860;33059.33881322408;33286.500702489;33393;32960.505592415655;33255.50116748202;33411.498827518095;33755.831220844724;33861.830690846386;27968.30079248035;29370.55944160882;30113.24716882008;30189.396212076073;30246.09261722152;23470.530589388458;24097.638535422335;24320;24459;24463.26610201697 19:13:59 INFO - PROCESS | 9747 | |2;jquery.html;346;366.19985332049475;373.712241573988;374.859427714607;391.3405911039898;12628.158664300528;12849.935750321247;14221.786673199897;15807.209639518036;17320;14298.285085745723;14369.209693466855;14398.784018239734;14528.927355363236;14550.126992380465;4956.207006878891;5198.792048318062;6498.642574658392;6839.384455399013;6878.071460352863;3916;6781.864362712743;6924.723011079551;6927.445804335666;6931.341522555349;4252.447181866353;4304.053108316165;6934.653267336613;6965.860682786341;6979.965100174518;6583.769568065142;6715.899261511081;6960.547564408323;6968.268331825187;6971.930280697205;6520.804375868732;6570.8028759137305;6577.440917522016;6580.967095164541;6583.374579414948;22218.222362217406;23412.531749365087;23448.179313724107;23452;23606.29181124569;1773.9923772988702;1809.8280663336961;2022.0597422198748;2129.33990462957;2155.956880862374;13676;14433.329833980748;14608.269586520737;14618.926905365404;15088.54734357971;1778.2217782217783;1795.6049669072784;1843.2903332217059;1862.1154951398114;1896.506908203877;81123.10070429856;82720.58639706823;82938.17061829426;83974.58012709959;85954.57022714909;15912.840871591136;16310;16366.754498682529;16736.58158546022;16754.162291885357;28290.019698620898;28403.71596284052;28444.431111377657;28478;28652.426951460853;8744.387892847566;8811.911880881238;8990.460572365679;9181.632734690671;9375.156235938663;7384.2246564111065;7393.852122957511;7414.814629634302;7601.973733546011;7645.120811106683;8229.95885020571;8299.875501867476;8410.116937721574;8500.787480313042;8647.913520864711;3037.9392412152074;3145.9528107078413;3267.607887053521;3287.178205448638;3404.506346579732;806.5241507510597;829.0383155539545;873.676739606337;890.9866352004725;921.8663293822358;15919.920400398156;16478.505644830675;16580.58548536296;16602.91698541524;17530.737038944426;808.1231863428246;812.9227723366271;816.2653611749473;837.9329653627817;853.185208126238;6835.863282734417;9207.125323094295;9319.627214911328;9429.952850235704;9623;328383;331795;333906;334710;339496;43323.35014974778;44672.10655786866;47198.52801471941;55628.72185639046;59689.40310596925;839.1440730454901;851.4550687559966;876.9956150219208;877.1666916429417;879.4195830751673;14954.775678364616;15449.459268925533;15892.205389730236;15972.440964566184;16243.269052892412;25357.366065848502;31596.684033160294;35883.82058089693;36467.27065458729;36638.80167189977;47666.76166619144;49211.261831071846;49228.75385623049;49767;49903.500964989886;7479.813004674927;7482.1021477423055;7702.383809295131;7722.7297044603165;7827.237716659122;8965.50689712072;11306.660800176009;11644.444886174242;11645.47595358194;11835.526578936746;9435.57539910692;9816.950915245377;9933.751656208364;10425.0096240857;10860.294080884718;10392.116670083127;10403.94798026005;10577.259591828499;10616.256862019585;10691.839622405514;10408.375497470177;10652.553124008658;10678.359298442118;10702.678919632424;10818.481324177339;7470;7572.67016693173;7620.161782203842;7648.923510764821;8031.317338026333;7990.320822730133;9254;10366.222533310183;10527.210459215436;10676.199285053808 19:13:59 INFO - PROCESS | 9747 | |3;mootools.html;1332.280568493014;1356.830396200475;1413.2509769821997;1613.1934032983509;1626.5852207687037;6770.22142453618;7233.204347521769;7233.565986040841;7236.13166420029;7240.420766338693;6174;6342.492600591953;6362.9045564316575;6523.151990241262;7064.894026589605;1823.5714607067328;1987.831034362081;2062.1648232465877;2074.471009892475;2087.269455690511;2091.5568257902;2093.1836583732356;2128.925487607934;2130.563234536924;2142.368001439579;1748.6502699460095;1812.900290484023;2038.551518665891;2055.835533157351;2057.8353731701504;2050.8256798172174;2117.957640847182;2125.532382875765;2138.9358319250446;2139.732533433321;2038.4019483123125;2061.938141855747;2064.0711679744177;2076.8234700050516;2087.4676957375923;7122.893156602655;7163.67763450646;7184.209736928934;7185;7185.928140718631;4199.958000420018;4340.978295108504;4342.240107981091;4343.19650864591;4349.543297953701;2688.717684643104;2800.425912687894;2906.607607972918;2914.985425072861;2922.167182353019;841.9579021048984;909.8680691299791;915.8992510823871;921.7096614566457;931.1340453378356;8799.472031678055;9050.86423703645;9110.590023448894;9193.494357810318;9419.105185007413;3761.4733937248807;3826.9808650956566;3957.426173204869;3962.445257663929;3981.144054028398;8219;8233.79415514617;8233.83532329362;8238.794030149294;8239.629216685264;4408.911821763547;4415.094905544356;4416.447944006999;4416.514183439819;4420.336949457543;3836.36699944506;4005.5193376794973;4006.0385507477995;4009;4009.659178969762;3141.4816555268126;3208.5828842250357;3245.3671534051105;3267.575215222006;3294.1929227339456;1024.8667673202435;1061.124572227915;1067.2795862792584;1075.5912753153752;1080.0495563903714;635.9713812878339;672.0792514255501;820.2125959079232;831.2020460358003;868.1665601023088;4713.269443236304;4910.607151427877;4926.458089610212;4928.28539861718;4934.111859865258;454.40246076409414;454.72943598558805;463.07847383706184;756.8486302739474;854.1799872122832;3359.764816462873;3535.876244331436;3536.345776031391;3566.625504322009;3667.9266414671556;7871.252231038042;8371.372147088992;8431.19903609156;8505.106963768716;8522.70170544028;8277.8344433111;8354.28988535969;8362.916370836214;8371.079181290053;8426.620802063922;6408.295087540367;6424.678766061678;6486.54594178403;6500.967495162399;6502.057201705727;4873.293372460902;4886.047220792054;4970.428400733962;5007.874803129951;5030.899382012412;7619.771406857803;7631.618419079135;7643;7655.2344765523;7657.234276572298;7675.347595454449;7903.446758726834;7941.285284324207;7955.602219889098;8006.719764808204;5993.160957465871;6134.171886795404;6148.077788331786;6169.84575385619;6178.382161783786;6559.836004099936;6600.141981542369;6619.635920024252;6626.304238055128;6639.236487803964;5366.356037275552;5964.194833697396;6090.390960903874;6177.752889884534;6192.442680158807;5501.339839219319;6074.969625151846;6086.056661217518;6208.9689551551955;6228.719707613078;5991.580589358703;6001.849953751192;6063.363346848518;6066.059760737093;6069.575129740876;4307.676924230758;4346.413234213341;4467.173572888896;4509.34614480905;4517.977410112929;4343.370211319404;4408.162449134654;4541.545845415432;4564.497905230488;4576.3593096967115 19:13:59 INFO - PROCESS | 9747 | |4;prototype.html;284.6527236771139;285.71000434558914;292.0100858091073;295.61569959053224;296.7240466366279;4754.286856971456;4791.281307803827;4815.542523460274;4829.903401931963;4833.8791530211765;4683.789229484672;4694.356975058737;4752.738599377033;4755.239161734124;4764.809407623691;3580.1944562473495;3584.946225806615;3636.690881275095;3663.670269675729;3669.2478042001326;3667.889963301105;3669.192777588926;3684.926301473969;3685.3366394049062;3692.593814680383;3651.963480365202;3667;3667.266546690659;3668.669819716225;3669.559742771054;3541;3653.241802439168;3678.742488025826;3746.9437958430644;3763.8870833875026;3308.8511017004294;3312.370649576597;3318.606185402137;3331.816750078745;3341.6992470677756;4580.633549316047;4591.150637132141;4593.954060459386;4615.407684348927;4623.74569398683;4081.673466122733;4257.510386305584;4266.658667306608;4269.761769086961;4271.081717430768;4886.560209581155;4901.03487390131;4933.136701077333;4939.492959998405;4950.702957822542;3601.5689409648644;3608.819559022065;3618.3486972344967;3622.1527021219367;3622.1669016126175;5003.849884503471;5154.226865970097;5154.7422628868035;5156.587473002151;5158.19463187885;3576.1059735066233;3587.695045921126;3616.8010759407957;3619.9638003620153;3622.2574372253625;3620.963790362063;3630.945535816965;3644.6355364463343;3652.8721494747556;3665.7902892045563;4124.216398884202;4139.937900931428;4142.896427589274;4149.585041495826;4151.501819781645;4686.179918514246;4862.565543164775;4867.537583929521;4893.21708526634;4916.164252077156;1238.7921776268067;1254.9144989584127;1258.150748244931;1258.7671280813079;1259.7480503899258;809.2191035650626;829.6598394658282;834.8872902158131;838.7609531283555;838.7861095420628;4135.31767258405;4218.915621687611;4378.562143785596;4384.254676704968;4407.977960110243;5028.321176641107;5051.292819005343;5074.3211171900075;5094.2103973884105;5121.41236216774;4400.185965596311;4403.823847046082;4403.911921761547;4404.216292401583;4406.647468202536;2482.2305085423577;2603.166986564281;2617.7120516743144;2625.4355313607666;2626.960595591068;4573.748443835621;4593.63250939924;4616.815327386934;4618.376519169869;4628.699134556243;5042.067187593683;5049.01544198885;5054.7472626368535;5061.772220250097;5062.620303477181;4508.571685689854;4771.308160316804;4784.952150478521;4801.783919723551;4812.374391329105;5135.409427915688;5135.922961155511;5143.794248230179;5150.768215430389;5168.922466162935;4852.611791056777;5063;5067.265246539305;5068.670536415121;5074.16276314404;4744.572988431058;4750.128645154188;4761.500042495627;4776.904461910812;4782.139214941205;3497.7901325920525;3501.474778783203;3505.8247087645004;3507.5440192774777;3515.1739341255297;5113.156329205788;5133.895103007749;5164.483551644956;5164.896702066013;5173.974130129325;4821.349117869183;4990.301357809837;4995.500449954975;4996.6252531061045;5020.297158397754;4987.576056035277;4994.700317980933;5007.524285192901;5011.448740638454;5031.245313203049;4920.335754673217;4927.704337739747;4933.33399991011;4936.605071594192;4952.975235123801;4730.645201609962;4778.952210477851;4904.6321525886415;4915.18899381598;4939.950600493949;4920.36035315421;4928.950710492849;4934.407871055496;4937.506249375034;4939.160342741814 19:13:59 INFO - PROCESS | 9747 | |5;yui.html;622.4024936061381;655.6951017776732;666.8266250774797;713.3544142550993;732.7069172331067;11648.242864213831;12094.092943029285;12100.69748256294;12116.030717542597;12116.939415302922;12160.513579456834;12208.816867746991;12236.755264894697;12287.262764234152;12296.93851530741;609.1259043272895;627.1721327847243;746.1941103608117;756.43267549338;768.6272158003364;773.9883901741479;776.2935728487078;776.3556248313914;776.6000509737489;776.6582703610421;818.4271010292819;819.1276290750332;820.5979070255592;820.7455688736511;820.8809722590221;644.3846126948777;662.0896267632006;779.3414564692825;810.8175660476346;816.391788117853;593.9643621382687;595.0122796158356;595.3718826637895;595.7140572525212;596.0701305962712;12287.631371058882;12301.261924284572;12318.876811231863;12326.630201093982;12362.814557781641;11985.700357491045;12025.939870300592;12120.212186207867;12133.635990920286;12731.490740370375;11141.888581114246;11245.71885702864;11319.320840749582;11403.942980285046;11570.884291157065;3165.082126183427;3322.0366093833;3998.6001399860074;4034.11249525104;4129.525104612978;47332.763336183445;48206.27690584609;48943.510564894605;49227.75386123082;49506.257406138575;9576.090271424204;9622.422654640744;9633.759156021155;9716.902830971741;9763.951180244054;16357.83642163587;16524;16641.334346625998;16803.075830829177;17035.23341449638;6268.310485846553;6375.776847810304;6446.258680251737;6517.771877984248;6614.152918183678;3530.3645343837843;3639.7088232941833;3648.5074514940675;3665.87169449068;3697.6487233712755;2726.5228584997544;2799.846008469554;2825.802193846452;2831.0940499040107;2834.9007784727846;470.7716757372672;475.5030992612728;475.76449657419107;478.7438720284631;481.40546425164894;489.168413696717;492.8817083899838;533.4771923514977;599.6042611876228;624.2945471617044;7869.685212591547;7887.763367098996;8184.304334131665;8719.433236839584;8724.171203735636;472.58648682402895;523.759070827416;568.3946596874398;607.9300880398811;638.4062821575978;3423.691867731916;3787.394016957274;3843.0394587156043;3967.9603203968168;4048.08917993455;35395.82302088473;37812.81093594514;37885.43171852425;38029.23941521154;44246;34644;37677.43483847744;46658;56644.15033774497;56834;32023;39352.60647393547;49899.75050124799;51525.7423712894;51804.740976294124;7535;7699.3840492761565;7733.852450833493;7831.569263690551;7871.134175240833;34125.65874341324;34214.657853421144;34378.48432273468;35850.46224306586;35923;42723.35914961216;46586;47922;48577.514224857296;49974.750126249135;9243.722688319362;9249.398789078688;9292.767680808034;9328.253739700944;9368.57841397125;10600.734981625212;10905.236633435583;11521.711957200801;11601.883981160081;11870.703232419259;11517.702451032032;11625.941870290595;11849.644510664693;11989.64031079069;12040.157188996685;11032.944835275772;11181.552737890393;11296.774064518828;11311.377874216998;11938.76122477563;11162.330260184415;11219.55121795119;11272.718182045515;11837.940810295893;12092.214006089576;8970.282377409661;9283.210927071275;9298.72103836886;9366.578503967201;9466.242700584075;9454.246129739391;10105;10191.54138063774;10210.387376757419;10267.794644106927 19:13:59 INFO - PROCESS | 9747 | __end_tp_report 19:13:59 INFO - PROCESS | 9747 | __start_cc_report 19:13:59 INFO - PROCESS | 9747 | _x_x_mozilla_cycle_collect,1492 19:13:59 INFO - PROCESS | 9747 | __end_cc_report 19:13:59 INFO - PROCESS | 9747 | __startTimestamp1480043639379__endTimestamp 19:13:59 INFO - PROCESS | 9747 | 19:13:59 INFO - PROCESS | 9747 | ------- Summary: start ------- 19:13:59 INFO - PROCESS | 9747 | Number of tests: 6 19:13:59 INFO - PROCESS | 9747 | 19:13:59 INFO - PROCESS | 9747 | [#0] dojo.html Cycles:165 Average:4554.06 Median:4650.72 stddev:470.70 (10.1%) stddev-sans-first:444.51 19:13:59 INFO - PROCESS | 9747 | Values: 2528.5 2569.1 2573.2 2584.5 2594.4 4454.9 4516.4 4599.6 4600.0 4625.9 4528.8 4542.7 4546.9 4550.6 4553.1 4172.2 4194.8 4219.7 4229.9 4236.6 4219.8 4279.3 4297.8 4330.7 4368.5 4232.2 4274.9 4284.9 4299.5 4351.2 4295.4 4300.8 4304.0 4308.8 4357.0 4146.0 4192.0 4230.1 4257.4 4299.4 4246.9 4505.1 4612.2 4648.3 4652.8 4931.2 4933.5 4952.4 4958.3 4985.7 4988.4 4996.7 4997.4 5003.2 5033.5 4459.4 4544.0 4548.2 4650.7 4703.1 4979.2 5025.5 5046.0 5065.6 5117.8 4863.8 4868.4 4868.9 4872.5 4916.1 4754.8 4926.8 4950.8 4951.9 4991.5 4781.1 4801.5 4836.4 4856.2 4883.4 4867.2 4867.4 4871.6 4873.2 4909.1 4273.7 4283.3 4288.2 4296.3 4323.1 3647.1 3668.3 3683.6 3684.8 3689.7 4266.0 4289.5 4295.2 4317.3 4320.5 4968.9 4969.4 4972.1 4976.5 5012.0 4150.0 4191.3 4202.8 4291.5 4326.2 4453.8 4461.5 4469.2 4471.4 4472.7 4514.4 4559.4 4566.0 4567.6 4573.9 4910.2 4916.3 4921.1 4935.1 4958.5 4630.6 4631.1 4666.9 4675.6 4680.3 4881.5 4918.8 4921.5 4924.2 4966.6 4783.9 4848.2 4941.2 4952.1 5002.6 4755.2 4764.4 4764.5 4766.2 4767.5 4714.1 4731.7 4762.4 4762.9 4776.0 4725.7 4729.1 4730.2 4775.6 4778.2 4818.7 4824.7 4826.6 4835.9 4872.0 4586.1 4630.4 4642.0 4651.1 4716.6 19:13:59 INFO - PROCESS | 9747 | 19:13:59 INFO - PROCESS | 9747 | [#1] ext.html Cycles:180 Average:46253.16 Median:3448.73 stddev:82113.29 (2381.0%) stddev-sans-first:82271.93 19:13:59 INFO - PROCESS | 9747 | Values: 546.8 550.3 557.1 567.9 572.1 28815.7 38440.4 39804.6 39878.6 44359.6 40261.6 40848.8 40850.6 40865.2 40870.8 7392.5 7476.0 7592.9 7621.7 7626.2 7371.8 9501.8 9767.0 9767.4 10024.5 9486.9 9521.2 9523.1 9524.9 9530.6 9525.3 9569.6 9574.7 9582.3 9583.0 9764.9 9822.3 9826.5 9827.6 9833.6 37530.4 37827.8 37836.6 37842.2 37861.4 2944.2 2949.5 2994.7 3007.9 3022.8 27925.9 27968.7 28311.3 28471.9 28630.9 3387.7 3445.9 3448.2 3449.3 3466.8 252604.0 253124.0 253653.0 253798.0 254446.0 52940.0 53032.5 53404.2 53423.0 53429.0 49550.3 49892.0 49960.8 49978.5 49994.8 14452.3 14850.9 14885.1 14890.9 14897.2 10098.8 10541.2 11043.1 11074.8 11090.2 16401.9 16666.3 16685.3 16697.7 16733.8 6198.2 6198.9 6226.6 6244.3 6559.1 767.9 810.6 840.9 928.0 974.7 26838.5 27952.7 28410.0 28441.3 28472.6 918.5 924.9 935.6 999.8 1032.3 14103.5 14869.4 15013.5 15253.8 15271.0 347885.0 349452.0 351548.0 351552.0 351822.0 49131.0 49196.0 49254.5 49290.8 49401.8 1012.4 1076.7 1108.7 1137.4 1168.0 25124.7 27801.6 29026.7 31303.5 32016.2 46752.1 47325.0 47383.5 47440.8 47520.0 323100.0 325659.0 326298.0 326803.0 327879.0 21836.3 22679.7 22689.8 23824.2 24391.8 37648.6 37813.0 38071.8 38629.0 39712.0 32647.5 32675.7 32676.8 32870.8 32896.5 32315.7 32860.0 33059.3 33286.5 33393.0 32960.5 33255.5 33411.5 33755.8 33861.8 27968.3 29370.6 30113.2 30189.4 30246.1 23470.5 24097.6 24320.0 24459.0 24463.3 19:13:59 INFO - PROCESS | 9747 | 19:13:59 INFO - PROCESS | 9747 | [#2] jquery.html Cycles:180 Average:23228.52 Median:4278.25 stddev:55155.26 (1289.2%) stddev-sans-first:55283.23 19:13:59 INFO - PROCESS | 9747 | Values: 346.0 366.2 373.7 374.9 391.3 12628.2 12849.9 14221.8 15807.2 17320.0 14298.3 14369.2 14398.8 14528.9 14550.1 4956.2 5198.8 6498.6 6839.4 6878.1 3916.0 6781.9 6924.7 6927.4 6931.3 4252.4 4304.1 6934.7 6965.9 6980.0 6583.8 6715.9 6960.5 6968.3 6971.9 6520.8 6570.8 6577.4 6581.0 6583.4 22218.2 23412.5 23448.2 23452.0 23606.3 1774.0 1809.8 2022.1 2129.3 2156.0 13676.0 14433.3 14608.3 14618.9 15088.5 1778.2 1795.6 1843.3 1862.1 1896.5 81123.1 82720.6 82938.2 83974.6 85954.6 15912.8 16310.0 16366.8 16736.6 16754.2 28290.0 28403.7 28444.4 28478.0 28652.4 8744.4 8811.9 8990.5 9181.6 9375.2 7384.2 7393.9 7414.8 7602.0 7645.1 8230.0 8299.9 8410.1 8500.8 8647.9 3037.9 3146.0 3267.6 3287.2 3404.5 806.5 829.0 873.7 891.0 921.9 15919.9 16478.5 16580.6 16602.9 17530.7 808.1 812.9 816.3 837.9 853.2 6835.9 9207.1 9319.6 9430.0 9623.0 328383.0 331795.0 333906.0 334710.0 339496.0 43323.4 44672.1 47198.5 55628.7 59689.4 839.1 851.5 877.0 877.2 879.4 14954.8 15449.5 15892.2 15972.4 16243.3 25357.4 31596.7 35883.8 36467.3 36638.8 47666.8 49211.3 49228.8 49767.0 49903.5 7479.8 7482.1 7702.4 7722.7 7827.2 8965.5 11306.7 11644.4 11645.5 11835.5 9435.6 9817.0 9933.8 10425.0 10860.3 10392.1 10403.9 10577.3 10616.3 10691.8 10408.4 10652.6 10678.4 10702.7 10818.5 7470.0 7572.7 7620.2 7648.9 8031.3 7990.3 9254.0 10366.2 10527.2 10676.2 19:13:59 INFO - PROCESS | 9747 | 19:13:59 INFO - PROCESS | 9747 | [#3] mootools.html Cycles:180 Average:4655.94 Median:4989.15 stddev:2486.16 (49.8%) stddev-sans-first:2480.59 19:13:59 INFO - PROCESS | 9747 | Values: 1332.3 1356.8 1413.3 1613.2 1626.6 6770.2 7233.2 7233.6 7236.1 7240.4 6174.0 6342.5 6362.9 6523.2 7064.9 1823.6 1987.8 2062.2 2074.5 2087.3 2091.6 2093.2 2128.9 2130.6 2142.4 1748.7 1812.9 2038.6 2055.8 2057.8 2050.8 2118.0 2125.5 2138.9 2139.7 2038.4 2061.9 2064.1 2076.8 2087.5 7122.9 7163.7 7184.2 7185.0 7185.9 4200.0 4341.0 4342.2 4343.2 4349.5 2688.7 2800.4 2906.6 2915.0 2922.2 842.0 909.9 915.9 921.7 931.1 8799.5 9050.9 9110.6 9193.5 9419.1 3761.5 3827.0 3957.4 3962.4 3981.1 8219.0 8233.8 8233.8 8238.8 8239.6 4408.9 4415.1 4416.4 4416.5 4420.3 3836.4 4005.5 4006.0 4009.0 4009.7 3141.5 3208.6 3245.4 3267.6 3294.2 1024.9 1061.1 1067.3 1075.6 1080.0 636.0 672.1 820.2 831.2 868.2 4713.3 4910.6 4926.5 4928.3 4934.1 454.4 454.7 463.1 756.8 854.2 3359.8 3535.9 3536.3 3566.6 3667.9 7871.3 8371.4 8431.2 8505.1 8522.7 8277.8 8354.3 8362.9 8371.1 8426.6 6408.3 6424.7 6486.5 6501.0 6502.1 4873.3 4886.0 4970.4 5007.9 5030.9 7619.8 7631.6 7643.0 7655.2 7657.2 7675.3 7903.4 7941.3 7955.6 8006.7 5993.2 6134.2 6148.1 6169.8 6178.4 6559.8 6600.1 6619.6 6626.3 6639.2 5366.4 5964.2 6090.4 6177.8 6192.4 5501.3 6075.0 6086.1 6209.0 6228.7 5991.6 6001.8 6063.4 6066.1 6069.6 4307.7 4346.4 4467.2 4509.3 4518.0 4343.4 4408.2 4541.5 4564.5 4576.4 19:13:59 INFO - PROCESS | 9747 | 19:13:59 INFO - PROCESS | 9747 | [#4] prototype.html Cycles:180 Average:4101.69 Median:4656.24 stddev:1195.79 (25.7%) stddev-sans-first:1164.32 19:13:59 INFO - PROCESS | 9747 | Values: 284.7 285.7 292.0 295.6 296.7 4754.3 4791.3 4815.5 4829.9 4833.9 4683.8 4694.4 4752.7 4755.2 4764.8 3580.2 3584.9 3636.7 3663.7 3669.2 3667.9 3669.2 3684.9 3685.3 3692.6 3652.0 3667.0 3667.3 3668.7 3669.6 3541.0 3653.2 3678.7 3746.9 3763.9 3308.9 3312.4 3318.6 3331.8 3341.7 4580.6 4591.2 4594.0 4615.4 4623.7 4081.7 4257.5 4266.7 4269.8 4271.1 4886.6 4901.0 4933.1 4939.5 4950.7 3601.6 3608.8 3618.3 3622.2 3622.2 5003.8 5154.2 5154.7 5156.6 5158.2 3576.1 3587.7 3616.8 3620.0 3622.3 3621.0 3630.9 3644.6 3652.9 3665.8 4124.2 4139.9 4142.9 4149.6 4151.5 4686.2 4862.6 4867.5 4893.2 4916.2 1238.8 1254.9 1258.2 1258.8 1259.7 809.2 829.7 834.9 838.8 838.8 4135.3 4218.9 4378.6 4384.3 4408.0 5028.3 5051.3 5074.3 5094.2 5121.4 4400.2 4403.8 4403.9 4404.2 4406.6 2482.2 2603.2 2617.7 2625.4 2627.0 4573.7 4593.6 4616.8 4618.4 4628.7 5042.1 5049.0 5054.7 5061.8 5062.6 4508.6 4771.3 4785.0 4801.8 4812.4 5135.4 5135.9 5143.8 5150.8 5168.9 4852.6 5063.0 5067.3 5068.7 5074.2 4744.6 4750.1 4761.5 4776.9 4782.1 3497.8 3501.5 3505.8 3507.5 3515.2 5113.2 5133.9 5164.5 5164.9 5174.0 4821.3 4990.3 4995.5 4996.6 5020.3 4987.6 4994.7 5007.5 5011.4 5031.2 4920.3 4927.7 4933.3 4936.6 4953.0 4730.6 4779.0 4904.6 4915.2 4940.0 4920.4 4929.0 4934.4 4937.5 4939.2 19:13:59 INFO - PROCESS | 9747 | 19:13:59 INFO - PROCESS | 9747 | [#5] yui.html Cycles:180 Average:12893.37 Median:23564.39 stddev:14745.27 (62.6%) stddev-sans-first:14757.84 19:13:59 INFO - PROCESS | 9747 | Values: 622.4 655.7 666.8 713.4 732.7 11648.2 12094.1 12100.7 12116.0 12116.9 12160.5 12208.8 12236.8 12287.3 12296.9 609.1 627.2 746.2 756.4 768.6 774.0 776.3 776.4 776.6 776.7 818.4 819.1 820.6 820.7 820.9 644.4 662.1 779.3 810.8 816.4 594.0 595.0 595.4 595.7 596.1 12287.6 12301.3 12318.9 12326.6 12362.8 11985.7 12025.9 12120.2 12133.6 12731.5 11141.9 11245.7 11319.3 11403.9 11570.9 3165.1 3322.0 3998.6 4034.1 4129.5 47332.8 48206.3 48943.5 49227.8 49506.3 9576.1 9622.4 9633.8 9716.9 9764.0 16357.8 16524.0 16641.3 16803.1 17035.2 6268.3 6375.8 6446.3 6517.8 6614.2 3530.4 3639.7 3648.5 3665.9 3697.6 2726.5 2799.8 2825.8 2831.1 2834.9 470.8 475.5 475.8 478.7 481.4 489.2 492.9 533.5 599.6 624.3 7869.7 7887.8 8184.3 8719.4 8724.2 472.6 523.8 568.4 607.9 638.4 3423.7 3787.4 3843.0 3968.0 4048.1 35395.8 37812.8 37885.4 38029.2 44246.0 34644.0 37677.4 46658.0 56644.2 56834.0 32023.0 39352.6 49899.8 51525.7 51804.7 7535.0 7699.4 7733.9 7831.6 7871.1 34125.7 34214.7 34378.5 35850.5 35923.0 42723.4 46586.0 47922.0 48577.5 49974.8 9243.7 9249.4 9292.8 9328.3 9368.6 10600.7 10905.2 11521.7 11601.9 11870.7 11517.7 11625.9 11849.6 11989.6 12040.2 11032.9 11181.6 11296.8 11311.4 11938.8 11162.3 11219.6 11272.7 11837.9 12092.2 8970.3 9283.2 9298.7 9366.6 9466.2 9454.2 10105.0 10191.5 10210.4 10267.8 19:13:59 INFO - PROCESS | 9747 | -------- Summary: end -------- 19:13:59 INFO - PROCESS | 9747 | 19:14:00 INFO - TEST-INFO | 9747: exit 0 19:14:00 INFO - TEST-OK | dromaeo_css | took 1123378ms 19:14:00 INFO - TEST-START | kraken 19:14:00 INFO - operating with platform_type : linux_ 19:14:00 INFO - Initialising browser for kraken test... 19:14:00 INFO - TEST-INFO | started process 10049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl9XodQ/profile http://localhost:42330/getInfo.html) 19:14:04 INFO - PROCESS | 10049 | __metrics Screen width/height:1600/1200 19:14:04 INFO - PROCESS | 10049 | colorDepth:24 19:14:04 INFO - PROCESS | 10049 | Browser inner width/height: 1024/697 19:14:04 INFO - PROCESS | 10049 | __metrics 19:14:05 INFO - PROCESS | 10049 | 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" 19:14:05 INFO - PROCESS | 10049 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:14:05 INFO - PROCESS | 10049 | console.error: PushService: 19:14:05 INFO - PROCESS | 10049 | stateChangeProcessEnqueue: Error transitioning state 19:14:05 INFO - PROCESS | 10049 | UnknownError 19:14:06 INFO - TEST-INFO | 10049: exit 0 19:14:06 INFO - Browser initialized. 19:14:06 INFO - Running cycle 1/1 for kraken test... 19:14:06 INFO - TEST-INFO | started process 10134 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl9XodQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:14:18 INFO - PROCESS | 10134 | RSS: Main: 174440448 19:14:18 INFO - PROCESS | 10134 | 19:14:21 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:42330/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42330/tests/kraken/driver.html?testName=audio-beat-detection) 19:14:22 INFO - PROCESS | 10134 | RSS: Main: 234872832 19:14:22 INFO - PROCESS | 10134 | 19:14:25 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:42330/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42330/tests/kraken/driver.html?testName=audio-dft) 19:14:26 INFO - PROCESS | 10134 | RSS: Main: 218279936 19:14:26 INFO - PROCESS | 10134 | 19:14:29 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:42330/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42330/tests/kraken/driver.html?testName=audio-fft) 19:14:29 INFO - PROCESS | 10134 | RSS: Main: 299909120 19:14:29 INFO - PROCESS | 10134 | 19:14:32 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:42330/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42330/tests/kraken/driver.html?testName=audio-oscillator) 19:14:32 INFO - PROCESS | 10134 | RSS: Main: 211787776 19:14:32 INFO - PROCESS | 10134 | 19:14:34 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:42330/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42330/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:14:35 INFO - PROCESS | 10134 | RSS: Main: 214622208 19:14:35 INFO - PROCESS | 10134 | 19:14:38 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:42330/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42330/tests/kraken/driver.html?testName=imaging-darkroom) 19:14:39 INFO - PROCESS | 10134 | RSS: Main: 252989440 19:14:39 INFO - PROCESS | 10134 | 19:14:42 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:42330/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42330/tests/kraken/driver.html?testName=imaging-desaturate) 19:14:43 INFO - PROCESS | 10134 | RSS: Main: 253112320 19:14:43 INFO - PROCESS | 10134 | 19:14:46 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:42330/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42330/tests/kraken/driver.html?testName=json-parse-financial) 19:14:46 INFO - PROCESS | 10134 | RSS: Main: 251592704 19:14:46 INFO - PROCESS | 10134 | 19:14:48 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:42330/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42330/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:14:49 INFO - PROCESS | 10134 | RSS: Main: 214224896 19:14:49 INFO - PROCESS | 10134 | 19:14:51 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:42330/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42330/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:14:51 INFO - PROCESS | 10134 | RSS: Main: 221667328 19:14:51 INFO - PROCESS | 10134 | 19:14:54 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:42330/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42330/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:14:54 INFO - PROCESS | 10134 | RSS: Main: 230223872 19:14:54 INFO - PROCESS | 10134 | 19:14:57 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:42330/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:14:58 INFO - PROCESS | 10134 | RSS: Main: 238997504 19:14:58 INFO - PROCESS | 10134 | 19:15:01 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:42330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:15:01 INFO - PROCESS | 10134 | RSS: Main: 235466752 19:15:01 INFO - PROCESS | 10134 | 19:15:03 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:42330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42330/tests/kraken/driver.html?testName=ai-astar) 19:15:03 INFO - PROCESS | 10134 | RSS: Main: 286953472 19:15:03 INFO - PROCESS | 10134 | 19:15:03 INFO - PROCESS | 10134 | __start_tp_report 19:15:03 INFO - PROCESS | 10134 | _x_x_mozilla_page_load 19:15:03 INFO - PROCESS | 10134 | _x_x_mozilla_page_load_details 19:15:03 INFO - PROCESS | 10134 | |i|pagename|runs| 19:15:03 INFO - PROCESS | 10134 | |0;ai-astar;106;115;114;115;115;115;114;114;118;115 19:15:03 INFO - PROCESS | 10134 | |1;audio-beat-detection;156;130;130;158;130;136;133;128;150;130 19:15:03 INFO - PROCESS | 10134 | |2;audio-dft;162;160;162;162;161;161;161;160;161;160 19:15:03 INFO - PROCESS | 10134 | |3;audio-fft;76;84;76;109;76;76;76;76;95;76 19:15:03 INFO - PROCESS | 10134 | |4;audio-oscillator;84;84;111;85;84;84;99;84;84;106 19:15:03 INFO - PROCESS | 10134 | |5;imaging-gaussian-blur;117;118;118;117;118;118;117;118;118;118 19:15:03 INFO - PROCESS | 10134 | |6;imaging-darkroom;148;148;146;147;147;147;147;147;146;146 19:15:03 INFO - PROCESS | 10134 | |7;imaging-desaturate;95;96;95;95;96;95;95;96;95;96 19:15:03 INFO - PROCESS | 10134 | |8;json-parse-financial;63;65;64;63;65;64;64;64;66;66 19:15:03 INFO - PROCESS | 10134 | |9;json-stringify-tinderbox;66;66;66;67;67;67;66;68;66;67 19:15:03 INFO - PROCESS | 10134 | |10;stanford-crypto-aes;85;92;87;101;84;93;85;85;101;87 19:15:03 INFO - PROCESS | 10134 | |11;stanford-crypto-ccm;156;146;150;142;144;152;141;144;185;141 19:15:03 INFO - PROCESS | 10134 | |12;stanford-crypto-pbkdf2;180;181;182;186;184;181;177;178;179;183 19:15:03 INFO - PROCESS | 10134 | |13;stanford-crypto-sha256-iterative;71;69;70;69;69;69;68;69;68;69 19:15:03 INFO - PROCESS | 10134 | __end_tp_report 19:15:03 INFO - PROCESS | 10134 | __start_cc_report 19:15:03 INFO - PROCESS | 10134 | _x_x_mozilla_cycle_collect,1954 19:15:03 INFO - PROCESS | 10134 | __end_cc_report 19:15:03 INFO - PROCESS | 10134 | __startTimestamp1480043703972__endTimestamp 19:15:03 INFO - PROCESS | 10134 | 19:15:03 INFO - PROCESS | 10134 | ------- Summary: start ------- 19:15:03 INFO - PROCESS | 10134 | Number of tests: 14 19:15:03 INFO - PROCESS | 10134 | 19:15:03 INFO - PROCESS | 10134 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.00 stddev:3.07 (2.7%) stddev-sans-first:1.22 19:15:03 INFO - PROCESS | 10134 | Values: 106.0 115.0 114.0 115.0 115.0 115.0 114.0 114.0 118.0 115.0 19:15:03 INFO - PROCESS | 10134 | 19:15:03 INFO - PROCESS | 10134 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:134.50 stddev:11.80 (8.8%) stddev-sans-first:10.59 19:15:03 INFO - PROCESS | 10134 | Values: 156.0 130.0 130.0 158.0 130.0 136.0 133.0 128.0 150.0 130.0 19:15:03 INFO - PROCESS | 10134 | 19:15:03 INFO - PROCESS | 10134 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 19:15:03 INFO - PROCESS | 10134 | Values: 162.0 160.0 162.0 162.0 161.0 161.0 161.0 160.0 161.0 160.0 19:15:03 INFO - PROCESS | 10134 | 19:15:03 INFO - PROCESS | 10134 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:11.32 (14.9%) stddev-sans-first:11.80 19:15:03 INFO - PROCESS | 10134 | Values: 76.0 84.0 76.0 109.0 76.0 76.0 76.0 76.0 95.0 76.0 19:15:03 INFO - PROCESS | 10134 | 19:15:03 INFO - PROCESS | 10134 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:84.00 stddev:10.63 (12.7%) stddev-sans-first:11.01 19:15:03 INFO - PROCESS | 10134 | Values: 84.0 84.0 111.0 85.0 84.0 84.0 99.0 84.0 84.0 106.0 19:15:03 INFO - PROCESS | 10134 | 19:15:03 INFO - PROCESS | 10134 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 19:15:03 INFO - PROCESS | 10134 | Values: 117.0 118.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 118.0 19:15:03 INFO - PROCESS | 10134 | 19:15:03 INFO - PROCESS | 10134 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 19:15:03 INFO - PROCESS | 10134 | Values: 148.0 148.0 146.0 147.0 147.0 147.0 147.0 147.0 146.0 146.0 19:15:03 INFO - PROCESS | 10134 | 19:15:03 INFO - PROCESS | 10134 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:15:03 INFO - PROCESS | 10134 | Values: 95.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 19:15:03 INFO - PROCESS | 10134 | 19:15:03 INFO - PROCESS | 10134 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.50 stddev:1.07 (1.7%) stddev-sans-first:1.01 19:15:03 INFO - PROCESS | 10134 | Values: 63.0 65.0 64.0 63.0 65.0 64.0 64.0 64.0 66.0 66.0 19:15:03 INFO - PROCESS | 10134 | 19:15:03 INFO - PROCESS | 10134 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 19:15:03 INFO - PROCESS | 10134 | Values: 66.0 66.0 66.0 67.0 67.0 67.0 66.0 68.0 66.0 67.0 19:15:03 INFO - PROCESS | 10134 | 19:15:03 INFO - PROCESS | 10134 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:86.00 stddev:6.53 (7.6%) stddev-sans-first:6.67 19:15:03 INFO - PROCESS | 10134 | Values: 85.0 92.0 87.0 101.0 84.0 93.0 85.0 85.0 101.0 87.0 19:15:03 INFO - PROCESS | 10134 | 19:15:03 INFO - PROCESS | 10134 | [#11] stanford-crypto-ccm Cycles:10 Average:150.10 Median:148.00 stddev:13.25 (8.9%) stddev-sans-first:13.88 19:15:03 INFO - PROCESS | 10134 | Values: 156.0 146.0 150.0 142.0 144.0 152.0 141.0 144.0 185.0 141.0 19:15:03 INFO - PROCESS | 10134 | 19:15:03 INFO - PROCESS | 10134 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.10 Median:181.50 stddev:2.77 (1.5%) stddev-sans-first:2.91 19:15:03 INFO - PROCESS | 10134 | Values: 180.0 181.0 182.0 186.0 184.0 181.0 177.0 178.0 179.0 183.0 19:15:03 INFO - PROCESS | 10134 | 19:15:03 INFO - PROCESS | 10134 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:0.88 (1.3%) stddev-sans-first:0.60 19:15:03 INFO - PROCESS | 10134 | Values: 71.0 69.0 70.0 69.0 69.0 69.0 68.0 69.0 68.0 69.0 19:15:03 INFO - PROCESS | 10134 | -------- Summary: end -------- 19:15:03 INFO - PROCESS | 10134 | 19:15:05 INFO - TEST-INFO | 10134: exit 0 19:15:05 INFO - TEST-OK | kraken | took 64991ms 19:15:05 INFO - SUITE-END | took 1188s 19:15:05 INFO - Completed test suite (00:19:48) 19:15:05 INFO - javascript benchmark 19:15:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2528.469021505484, 2569.1136557887544, 2573.2151693733417, 2584.457263974565, 2594.416256342322, 4454.866354009377, 4516.36770852081, 4599.58603725665, 4599.9540004599985, 4625.930611040832, 4528.796204170812, 4542.727436353821, 4546.931796023054, 4550.590446859782, 4553.134904368176, 4172.165566886627, 4194.790260486979, 4219.725717828332, 4229.915401691965, 4236.555161708023, 4219.831206751726, 4279.293916503773, 4297.828086876521, 4330.675199360045, 4368.453943257093, 4232.238197124517, 4274.871753847389, 4284.871453856389, 4299.484061912575, 4351.173277077361, 4295.4201182840225, 4300.763458009808, 4304.0, 4308.784560771949, 4357.041450880801, 4145.97927010366, 4191.97904010481, 4230.132822771325, 4257.382679511485, 4299.441072660566, 4246.936295955563, 4505.098980203972, 4612.238980568202, 4648.2562789953445, 4652.790624421876, 4931.186354251544, 4933.481984391623, 4952.356193694833, 4958.281049247875, 4985.700857948535, 4988.426330971948, 4996.650234483587, 4997.375328083989, 5003.199488081926, 5033.546980771712, 4459.44256967879, 4544.0, 4548.204064288736, 4650.720956742606, 4703.0593881223895, 4979.228219625964, 5025.497450254945, 5045.974770126126, 5065.569426598707, 5117.795288188431, 4863.756812159378, 4868.391451068616, 4868.878278043077, 4872.4883887192045, 4916.115099282163, 4754.809807607726, 4926.778294976734, 4950.801967921315, 4951.851444456672, 4991.5258050485145, 4781.115493633689, 4801.4958429364415, 4836.371271734652, 4856.247281671276, 4883.389576302962, 4867.1969125093965, 4867.367242258554, 4871.634627402959, 4873.171560834667, 4909.091818013608, 4273.722208056529, 4283.293256612624, 4288.2281189385585, 4296.334068219431, 4323.0705398339505, 3647.0882279430143, 3668.284684486553, 3683.557973043198, 3684.778913265213, 3689.6679298863232, 4266.0, 4289.485261768607, 4295.205387003414, 4317.330813723815, 4320.4599425071865, 4968.8757781055765, 4969.378827646544, 4972.129877271463, 4976.502349765067, 5011.974940125276, 4149.962509372657, 4191.287481128215, 4202.831886724558, 4291.54938731435, 4326.2212801696, 4453.844115455943, 4461.531539188403, 4469.217886869785, 4471.396361491222, 4472.686911916199, 4514.390557274857, 4559.361689363492, 4565.9954809941755, 4567.611753001032, 4573.908521829611, 4910.189818679878, 4916.2625606157935, 4921.064997650435, 4935.111679897653, 4958.528939750718, 4630.629549636088, 4631.143238500888, 4666.906661866811, 4675.555822196886, 4680.274557443602, 4881.536254055859, 4918.827841025547, 4921.532454416824, 4924.187509060965, 4966.627502937366, 4783.928241076456, 4848.248521479177, 4941.234108713155, 4952.133376659142, 5002.649814512949, 4755.1916174251155, 4764.404449443819, 4764.4520880099235, 4766.237402015661, 4767.4994125617695, 4714.080754252887, 4731.69243999139, 4762.380890484214, 4762.904741905073, 4776.044791041736, 4725.692829966041, 4729.05418916225, 4730.1958667027375, 4775.594074503567, 4778.187708089564, 4818.68678535894, 4824.710517368969, 4826.638002149923, 4835.927461088017, 4871.97688485422, 4586.1057093866375, 4630.421197350332, 4642.0483800820075, 4651.116287905287, 4716.5990890774665], "value": 4524.32099936678, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.811350084221, 550.328599109087, 557.0919401375758, 567.892100500905, 572.0675299262202, 28815.711842881567, 38440.423393649115, 39804.60195398049, 39878.60121398785, 44359.55640443595, 40261.59738402615, 40848.79575602118, 40850.59149408505, 40865.18269634613, 40870.795646021725, 7392.519486233405, 7475.962620186891, 7592.924070759277, 7621.733239336624, 7626.237376262357, 7371.778846634609, 9501.762455938588, 9767.0, 9767.413955162678, 10024.548895299693, 9486.905130948671, 9521.190698790611, 9523.095305945924, 9524.8571271431, 9530.618775248982, 9525.333226674102, 9569.617215311378, 9574.664886728931, 9582.329236953416, 9582.952085239598, 9764.902350976541, 9822.312438129335, 9826.508674566243, 9827.557759900821, 9833.557489912972, 37530.43704344437, 37827.81086094579, 37836.62163378359, 37842.24315513702, 37861.43207851885, 2944.1903476543907, 2949.5133303004977, 2994.7005299470097, 3007.9248018799485, 3022.788404811664, 27925.860370698018, 27968.720312796817, 28311.292217694518, 28471.857640711663, 28630.85684571564, 3387.7120444762227, 3445.913852153691, 3448.189675426273, 3449.275652113059, 3466.843992020365, 252604.0, 253123.99999999817, 253653.0, 253798.0, 254446.0, 52940.0, 53032.46967530275, 53404.19893701598, 53423.0, 53429.0, 49550.256746148836, 49892.0, 49960.75019624879, 49978.50021499739, 49994.75002624963, 14452.349644266033, 14850.851491485162, 14885.106893586202, 14890.92554537242, 14897.18065506386, 10098.798024039477, 10541.156707463384, 11043.116550675926, 11074.778504430027, 11090.223684342018, 16401.917990409973, 16666.33334666624, 16685.33258669664, 16697.749533757004, 16733.83266167347, 6198.2252218472695, 6198.86139281947, 6226.5641405101205, 6244.250689917239, 6559.114519539897, 767.85794627994, 810.6473683947502, 840.878072679458, 928.0, 974.6907612602479, 26838.463230735277, 27952.72047279542, 28410.0, 28441.288967775556, 28472.572911406347, 918.5315489100607, 924.9121333473444, 935.5883411299006, 999.8050380175796, 1032.3496197395593, 14103.506377276746, 14869.405223791144, 15013.474528391454, 15253.847461525465, 15271.0, 347885.0, 349452.0, 351548.0, 351552.0, 351822.0, 49131.0, 49196.0, 49254.50745492571, 49290.75354623204, 49401.75299123553, 1012.427978192319, 1076.7254350140663, 1108.6563165418745, 1137.38581166171, 1168.0480408467072, 25124.74875251224, 27801.582976255777, 29026.7097329024, 31303.530447042856, 32016.199595010312, 46752.06495870132, 47325.0, 47383.52616473929, 47440.76279618718, 47520.0, 323100.0, 325659.0, 326298.0, 326803.0, 327879.0, 21836.344909652737, 22679.659805103267, 22689.773102269428, 23824.16615418452, 24391.756082438947, 37648.62351376451, 37813.0, 38071.809640951615, 38629.0, 39712.014399279346, 32647.510287345234, 32675.673243268215, 32676.83661581677, 32870.835645822575, 32896.506552402214, 32315.676843232206, 32860.0, 33059.33881322408, 33286.500702489, 33393.0, 32960.505592415655, 33255.50116748202, 33411.498827518095, 33755.831220844724, 33861.830690846386, 27968.30079248035, 29370.55944160882, 30113.24716882008, 30189.396212076073, 30246.09261722152, 23470.530589388458, 24097.638535422335, 24320.0, 24459.0, 24463.26610201697], "value": 17398.395339895033, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.0, 366.19985332049475, 373.712241573988, 374.859427714607, 391.3405911039898, 12628.158664300528, 12849.935750321247, 14221.786673199897, 15807.209639518036, 17320.0, 14298.285085745723, 14369.209693466855, 14398.784018239734, 14528.927355363236, 14550.126992380465, 4956.207006878891, 5198.792048318062, 6498.642574658392, 6839.384455399013, 6878.071460352863, 3916.0, 6781.864362712743, 6924.723011079551, 6927.445804335666, 6931.341522555349, 4252.447181866353, 4304.053108316165, 6934.653267336613, 6965.860682786341, 6979.965100174518, 6583.769568065142, 6715.899261511081, 6960.547564408323, 6968.268331825187, 6971.930280697205, 6520.804375868732, 6570.8028759137305, 6577.440917522016, 6580.967095164541, 6583.374579414948, 22218.222362217406, 23412.531749365087, 23448.179313724107, 23452.0, 23606.29181124569, 1773.9923772988702, 1809.8280663336961, 2022.0597422198748, 2129.33990462957, 2155.956880862374, 13676.0, 14433.329833980748, 14608.269586520737, 14618.926905365404, 15088.54734357971, 1778.2217782217783, 1795.6049669072784, 1843.2903332217059, 1862.1154951398114, 1896.506908203877, 81123.10070429856, 82720.58639706823, 82938.17061829426, 83974.58012709959, 85954.57022714909, 15912.840871591136, 16310.0, 16366.754498682529, 16736.58158546022, 16754.162291885357, 28290.019698620898, 28403.71596284052, 28444.431111377657, 28478.0, 28652.426951460853, 8744.387892847566, 8811.911880881238, 8990.460572365679, 9181.632734690671, 9375.156235938663, 7384.2246564111065, 7393.852122957511, 7414.814629634302, 7601.973733546011, 7645.120811106683, 8229.95885020571, 8299.875501867476, 8410.116937721574, 8500.787480313042, 8647.913520864711, 3037.9392412152074, 3145.9528107078413, 3267.607887053521, 3287.178205448638, 3404.506346579732, 806.5241507510597, 829.0383155539545, 873.676739606337, 890.9866352004725, 921.8663293822358, 15919.920400398156, 16478.505644830675, 16580.58548536296, 16602.91698541524, 17530.737038944426, 808.1231863428246, 812.9227723366271, 816.2653611749473, 837.9329653627817, 853.185208126238, 6835.863282734417, 9207.125323094295, 9319.627214911328, 9429.952850235704, 9623.0, 328383.0, 331795.0, 333906.0, 334710.0, 339496.0, 43323.35014974778, 44672.10655786866, 47198.52801471941, 55628.72185639046, 59689.40310596925, 839.1440730454901, 851.4550687559966, 876.9956150219208, 877.1666916429417, 879.4195830751673, 14954.775678364616, 15449.459268925533, 15892.205389730236, 15972.440964566184, 16243.269052892412, 25357.366065848502, 31596.684033160294, 35883.82058089693, 36467.27065458729, 36638.80167189977, 47666.76166619144, 49211.261831071846, 49228.75385623049, 49767.0, 49903.500964989886, 7479.813004674927, 7482.1021477423055, 7702.383809295131, 7722.7297044603165, 7827.237716659122, 8965.50689712072, 11306.660800176009, 11644.444886174242, 11645.47595358194, 11835.526578936746, 9435.57539910692, 9816.950915245377, 9933.751656208364, 10425.0096240857, 10860.294080884718, 10392.116670083127, 10403.94798026005, 10577.259591828499, 10616.256862019585, 10691.839622405514, 10408.375497470177, 10652.553124008658, 10678.359298442118, 10702.678919632424, 10818.481324177339, 7470.0, 7572.67016693173, 7620.161782203842, 7648.923510764821, 8031.317338026333, 7990.320822730133, 9254.0, 10366.222533310183, 10527.210459215436, 10676.199285053808], "value": 8962.516439842915, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.280568493014, 1356.830396200475, 1413.2509769821997, 1613.1934032983509, 1626.5852207687037, 6770.22142453618, 7233.204347521769, 7233.565986040841, 7236.13166420029, 7240.420766338693, 6174.0, 6342.492600591953, 6362.9045564316575, 6523.151990241262, 7064.894026589605, 1823.5714607067328, 1987.831034362081, 2062.1648232465877, 2074.471009892475, 2087.269455690511, 2091.5568257902, 2093.1836583732356, 2128.925487607934, 2130.563234536924, 2142.368001439579, 1748.6502699460095, 1812.900290484023, 2038.551518665891, 2055.835533157351, 2057.8353731701504, 2050.8256798172174, 2117.957640847182, 2125.532382875765, 2138.9358319250446, 2139.732533433321, 2038.4019483123125, 2061.938141855747, 2064.0711679744177, 2076.8234700050516, 2087.4676957375923, 7122.893156602655, 7163.67763450646, 7184.209736928934, 7185.0, 7185.928140718631, 4199.958000420018, 4340.978295108504, 4342.240107981091, 4343.19650864591, 4349.543297953701, 2688.717684643104, 2800.425912687894, 2906.607607972918, 2914.985425072861, 2922.167182353019, 841.9579021048984, 909.8680691299791, 915.8992510823871, 921.7096614566457, 931.1340453378356, 8799.472031678055, 9050.86423703645, 9110.590023448894, 9193.494357810318, 9419.105185007413, 3761.4733937248807, 3826.9808650956566, 3957.426173204869, 3962.445257663929, 3981.144054028398, 8219.0, 8233.79415514617, 8233.83532329362, 8238.794030149294, 8239.629216685264, 4408.911821763547, 4415.094905544356, 4416.447944006999, 4416.514183439819, 4420.336949457543, 3836.36699944506, 4005.5193376794973, 4006.0385507477995, 4009.0, 4009.659178969762, 3141.4816555268126, 3208.5828842250357, 3245.3671534051105, 3267.575215222006, 3294.1929227339456, 1024.8667673202435, 1061.124572227915, 1067.2795862792584, 1075.5912753153752, 1080.0495563903714, 635.9713812878339, 672.0792514255501, 820.2125959079232, 831.2020460358003, 868.1665601023088, 4713.269443236304, 4910.607151427877, 4926.458089610212, 4928.28539861718, 4934.111859865258, 454.40246076409414, 454.72943598558805, 463.07847383706184, 756.8486302739474, 854.1799872122832, 3359.764816462873, 3535.876244331436, 3536.345776031391, 3566.625504322009, 3667.9266414671556, 7871.252231038042, 8371.372147088992, 8431.19903609156, 8505.106963768716, 8522.70170544028, 8277.8344433111, 8354.28988535969, 8362.916370836214, 8371.079181290053, 8426.620802063922, 6408.295087540367, 6424.678766061678, 6486.54594178403, 6500.967495162399, 6502.057201705727, 4873.293372460902, 4886.047220792054, 4970.428400733962, 5007.874803129951, 5030.899382012412, 7619.771406857803, 7631.618419079135, 7643.0, 7655.2344765523, 7657.234276572298, 7675.347595454449, 7903.446758726834, 7941.285284324207, 7955.602219889098, 8006.719764808204, 5993.160957465871, 6134.171886795404, 6148.077788331786, 6169.84575385619, 6178.382161783786, 6559.836004099936, 6600.141981542369, 6619.635920024252, 6626.304238055128, 6639.236487803964, 5366.356037275552, 5964.194833697396, 6090.390960903874, 6177.752889884534, 6192.442680158807, 5501.339839219319, 6074.969625151846, 6086.056661217518, 6208.9689551551955, 6228.719707613078, 5991.580589358703, 6001.849953751192, 6063.363346848518, 6066.059760737093, 6069.575129740876, 4307.676924230758, 4346.413234213341, 4467.173572888896, 4509.34614480905, 4517.977410112929, 4343.370211319404, 4408.162449134654, 4541.545845415432, 4564.497905230488, 4576.3593096967115], "value": 3783.8260835511905, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.6527236771139, 285.71000434558914, 292.0100858091073, 295.61569959053224, 296.7240466366279, 4754.286856971456, 4791.281307803827, 4815.542523460274, 4829.903401931963, 4833.8791530211765, 4683.789229484672, 4694.356975058737, 4752.738599377033, 4755.239161734124, 4764.809407623691, 3580.1944562473495, 3584.946225806615, 3636.690881275095, 3663.670269675729, 3669.2478042001326, 3667.889963301105, 3669.192777588926, 3684.926301473969, 3685.3366394049062, 3692.593814680383, 3651.963480365202, 3667.0, 3667.266546690659, 3668.669819716225, 3669.559742771054, 3541.0, 3653.241802439168, 3678.742488025826, 3746.9437958430644, 3763.8870833875026, 3308.8511017004294, 3312.370649576597, 3318.606185402137, 3331.816750078745, 3341.6992470677756, 4580.633549316047, 4591.150637132141, 4593.954060459386, 4615.407684348927, 4623.74569398683, 4081.673466122733, 4257.510386305584, 4266.658667306608, 4269.761769086961, 4271.081717430768, 4886.560209581155, 4901.03487390131, 4933.136701077333, 4939.492959998405, 4950.702957822542, 3601.5689409648644, 3608.819559022065, 3618.3486972344967, 3622.1527021219367, 3622.1669016126175, 5003.849884503471, 5154.226865970097, 5154.7422628868035, 5156.587473002151, 5158.19463187885, 3576.1059735066233, 3587.695045921126, 3616.8010759407957, 3619.9638003620153, 3622.2574372253625, 3620.963790362063, 3630.945535816965, 3644.6355364463343, 3652.8721494747556, 3665.7902892045563, 4124.216398884202, 4139.937900931428, 4142.896427589274, 4149.585041495826, 4151.501819781645, 4686.179918514246, 4862.565543164775, 4867.537583929521, 4893.21708526634, 4916.164252077156, 1238.7921776268067, 1254.9144989584127, 1258.150748244931, 1258.7671280813079, 1259.7480503899258, 809.2191035650626, 829.6598394658282, 834.8872902158131, 838.7609531283555, 838.7861095420628, 4135.31767258405, 4218.915621687611, 4378.562143785596, 4384.254676704968, 4407.977960110243, 5028.321176641107, 5051.292819005343, 5074.3211171900075, 5094.2103973884105, 5121.41236216774, 4400.185965596311, 4403.823847046082, 4403.911921761547, 4404.216292401583, 4406.647468202536, 2482.2305085423577, 2603.166986564281, 2617.7120516743144, 2625.4355313607666, 2626.960595591068, 4573.748443835621, 4593.63250939924, 4616.815327386934, 4618.376519169869, 4628.699134556243, 5042.067187593683, 5049.01544198885, 5054.7472626368535, 5061.772220250097, 5062.620303477181, 4508.571685689854, 4771.308160316804, 4784.952150478521, 4801.783919723551, 4812.374391329105, 5135.409427915688, 5135.922961155511, 5143.794248230179, 5150.768215430389, 5168.922466162935, 4852.611791056777, 5063.0, 5067.265246539305, 5068.670536415121, 5074.16276314404, 4744.572988431058, 4750.128645154188, 4761.500042495627, 4776.904461910812, 4782.139214941205, 3497.7901325920525, 3501.474778783203, 3505.8247087645004, 3507.5440192774777, 3515.1739341255297, 5113.156329205788, 5133.895103007749, 5164.483551644956, 5164.896702066013, 5173.974130129325, 4821.349117869183, 4990.301357809837, 4995.500449954975, 4996.6252531061045, 5020.297158397754, 4987.576056035277, 4994.700317980933, 5007.524285192901, 5011.448740638454, 5031.245313203049, 4920.335754673217, 4927.704337739747, 4933.33399991011, 4936.605071594192, 4952.975235123801, 4730.645201609962, 4778.952210477851, 4904.6321525886415, 4915.18899381598, 4939.950600493949, 4920.36035315421, 4928.950710492849, 4934.407871055496, 4937.506249375034, 4939.160342741814], "value": 3720.0190910603687, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.4024936061381, 655.6951017776732, 666.8266250774797, 713.3544142550993, 732.7069172331067, 11648.242864213831, 12094.092943029285, 12100.69748256294, 12116.030717542597, 12116.939415302922, 12160.513579456834, 12208.816867746991, 12236.755264894697, 12287.262764234152, 12296.93851530741, 609.1259043272895, 627.1721327847243, 746.1941103608117, 756.43267549338, 768.6272158003364, 773.9883901741479, 776.2935728487078, 776.3556248313914, 776.6000509737489, 776.6582703610421, 818.4271010292819, 819.1276290750332, 820.5979070255592, 820.7455688736511, 820.8809722590221, 644.3846126948777, 662.0896267632006, 779.3414564692825, 810.8175660476346, 816.391788117853, 593.9643621382687, 595.0122796158356, 595.3718826637895, 595.7140572525212, 596.0701305962712, 12287.631371058882, 12301.261924284572, 12318.876811231863, 12326.630201093982, 12362.814557781641, 11985.700357491045, 12025.939870300592, 12120.212186207867, 12133.635990920286, 12731.490740370375, 11141.888581114246, 11245.71885702864, 11319.320840749582, 11403.942980285046, 11570.884291157065, 3165.082126183427, 3322.0366093833, 3998.6001399860074, 4034.11249525104, 4129.525104612978, 47332.763336183445, 48206.27690584609, 48943.510564894605, 49227.75386123082, 49506.257406138575, 9576.090271424204, 9622.422654640744, 9633.759156021155, 9716.902830971741, 9763.951180244054, 16357.83642163587, 16524.0, 16641.334346625998, 16803.075830829177, 17035.23341449638, 6268.310485846553, 6375.776847810304, 6446.258680251737, 6517.771877984248, 6614.152918183678, 3530.3645343837843, 3639.7088232941833, 3648.5074514940675, 3665.87169449068, 3697.6487233712755, 2726.5228584997544, 2799.846008469554, 2825.802193846452, 2831.0940499040107, 2834.9007784727846, 470.7716757372672, 475.5030992612728, 475.76449657419107, 478.7438720284631, 481.40546425164894, 489.168413696717, 492.8817083899838, 533.4771923514977, 599.6042611876228, 624.2945471617044, 7869.685212591547, 7887.763367098996, 8184.304334131665, 8719.433236839584, 8724.171203735636, 472.58648682402895, 523.759070827416, 568.3946596874398, 607.9300880398811, 638.4062821575978, 3423.691867731916, 3787.394016957274, 3843.0394587156043, 3967.9603203968168, 4048.08917993455, 35395.82302088473, 37812.81093594514, 37885.43171852425, 38029.23941521154, 44246.0, 34644.0, 37677.43483847744, 46658.0, 56644.15033774497, 56834.0, 32023.0, 39352.60647393547, 49899.75050124799, 51525.7423712894, 51804.740976294124, 7535.0, 7699.3840492761565, 7733.852450833493, 7831.569263690551, 7871.134175240833, 34125.65874341324, 34214.657853421144, 34378.48432273468, 35850.46224306586, 35923.0, 42723.35914961216, 46586.0, 47922.0, 48577.514224857296, 49974.750126249135, 9243.722688319362, 9249.398789078688, 9292.767680808034, 9328.253739700944, 9368.57841397125, 10600.734981625212, 10905.236633435583, 11521.711957200801, 11601.883981160081, 11870.703232419259, 11517.702451032032, 11625.941870290595, 11849.644510664693, 11989.64031079069, 12040.157188996685, 11032.944835275772, 11181.552737890393, 11296.774064518828, 11311.377874216998, 11938.76122477563, 11162.330260184415, 11219.55121795119, 11272.718182045515, 11837.940810295893, 12092.214006089576, 8970.282377409661, 9283.210927071275, 9298.72103836886, 9366.578503967201, 9466.242700584075, 9454.246129739391, 10105.0, 10191.54138063774, 10210.387376757419, 10267.794644106927], "value": 5869.857479282649, "unit": "score"}], "name": "dromaeo_css", "value": 6226.95149765425, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 114.0, 115.0, 115.0, 115.0, 114.0, 114.0, 118.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 130.0, 130.0, 158.0, 130.0, 136.0, 133.0, 128.0, 150.0, 130.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 162.0, 161.0, 161.0, 161.0, 160.0, 161.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 84.0, 76.0, 109.0, 76.0, 76.0, 76.0, 76.0, 95.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 111.0, 85.0, 84.0, 84.0, 99.0, 84.0, 84.0, 106.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 63.0, 65.0, 64.0, 64.0, 64.0, 66.0, 66.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 67.0, 67.0, 66.0, 68.0, 66.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 92.0, 87.0, 101.0, 84.0, 93.0, 85.0, 85.0, 101.0, 87.0], "value": 90.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 146.0, 150.0, 142.0, 144.0, 152.0, 141.0, 144.0, 185.0, 141.0], "value": 150.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 181.0, 182.0, 186.0, 184.0, 181.0, 177.0, 178.0, 179.0, 183.0], "value": 181.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 70.0, 69.0, 69.0, 69.0, 68.0, 69.0, 68.0, 69.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1566.9999999999998, "alertThreshold": 2.0}]} 19:15:05 INFO - Return code: 0 19:15:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:15:05 INFO - # TBPL SUCCESS # 19:15:05 INFO - Running post-action listener: _resource_record_post_action 19:15:05 INFO - [mozharness: 2016-11-25 03:15:05.784234Z] Finished run-tests step (success) 19:15:05 INFO - Running post-run listener: _resource_record_post_run 19:15:05 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406147072; Read time: 16; Write time: 241984 19:15:05 INFO - TinderboxPrint: CPU usage
13.0% 19:15:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 19:15:05 INFO - TinderboxPrint: I/O write bytes / time
406,147,072 / 241,984 19:15:05 INFO - TinderboxPrint: CPU idle
8,360.2 (87.0%) 19:15:05 INFO - TinderboxPrint: CPU user
1,203.1 (12.5%) 19:15:05 INFO - TinderboxPrint: Swap in / out
0 / 0 19:15:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115441664; Read time: 0; Write time: 66188 19:15:05 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 289808384; Read time: 0; Write time: 175772 19:15:06 INFO - Running post-run listener: _upload_blobber_files 19:15:06 INFO - Blob upload gear active. 19:15:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:15:06 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 19:15:06 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:15:06 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:15:06 INFO - (blobuploader) - INFO - Open directory for files ... 19:15:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:15:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:15:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:15:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:15:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:15:07 INFO - (blobuploader) - INFO - Done attempting. 19:15:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:15:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:15:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:15:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:15:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:15:11 INFO - (blobuploader) - INFO - Done attempting. 19:15:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:15:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:15:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:15:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:15:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:15:13 INFO - (blobuploader) - INFO - Done attempting. 19:15:13 INFO - (blobuploader) - INFO - Iteration through files over. 19:15:13 INFO - Return code: 0 19:15:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:15:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:15:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d421f2ac7fb207855749f0871f68cb92862ee0cafeb31c90864b49c80deb5b827ca28236865a55ab86d558dded7be10d2db4fdb948734b47aeb6870713531934", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0b30dd6618996d29b6d272a897042e38848f04f1cd4e775a31b0bd82289a76d7b19e98305a42dfa725381dbb38cdba69c925234b2b935682c12a978ca395416d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/43a4f9b329add78ae9e2cb7785afc6f69dfb13b861e0431e5bb41842afc2a4d465d4c34d3ecfdedc2d5015c06edc5eae514daed87dbe94ac18197cbd60133acd"} 19:15:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:15:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:15:13 INFO - Contents: 19:15:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d421f2ac7fb207855749f0871f68cb92862ee0cafeb31c90864b49c80deb5b827ca28236865a55ab86d558dded7be10d2db4fdb948734b47aeb6870713531934", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0b30dd6618996d29b6d272a897042e38848f04f1cd4e775a31b0bd82289a76d7b19e98305a42dfa725381dbb38cdba69c925234b2b935682c12a978ca395416d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/43a4f9b329add78ae9e2cb7785afc6f69dfb13b861e0431e5bb41842afc2a4d465d4c34d3ecfdedc2d5015c06edc5eae514daed87dbe94ac18197cbd60133acd"} 19:15:13 INFO - Running post-run listener: copy_logs_to_upload_dir 19:15:13 INFO - Copying logs to upload dir... 19:15:13 INFO - mkdir: /builds/slave/test/build/upload/logs 19:15:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.182206 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-11-24 19:15:12.965812) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 19:15:12.968992) ========= 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=4300f881736b422476174874000001bc-1480042190.923026-1534513708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d421f2ac7fb207855749f0871f68cb92862ee0cafeb31c90864b49c80deb5b827ca28236865a55ab86d558dded7be10d2db4fdb948734b47aeb6870713531934", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0b30dd6618996d29b6d272a897042e38848f04f1cd4e775a31b0bd82289a76d7b19e98305a42dfa725381dbb38cdba69c925234b2b935682c12a978ca395416d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/43a4f9b329add78ae9e2cb7785afc6f69dfb13b861e0431e5bb41842afc2a4d465d4c34d3ecfdedc2d5015c06edc5eae514daed87dbe94ac18197cbd60133acd"} build_url:https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011696 build_url: 'https://queue.taskcluster.net/v1/task/ISt0tAdWR4qKP0NffxcdjQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d421f2ac7fb207855749f0871f68cb92862ee0cafeb31c90864b49c80deb5b827ca28236865a55ab86d558dded7be10d2db4fdb948734b47aeb6870713531934", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0b30dd6618996d29b6d272a897042e38848f04f1cd4e775a31b0bd82289a76d7b19e98305a42dfa725381dbb38cdba69c925234b2b935682c12a978ca395416d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/43a4f9b329add78ae9e2cb7785afc6f69dfb13b861e0431e5bb41842afc2a4d465d4c34d3ecfdedc2d5015c06edc5eae514daed87dbe94ac18197cbd60133acd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 19:15:12.995076) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 19:15:12.995402) ========= 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=4300f881736b422476174874000001bc-1480042190.923026-1534513708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 19:15:13.080614) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 19:15:13.080984) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 19:15:13.081314) ========= ========= Total master_lag: 0.32 =========