builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1484666920.97 results: success (0) revision: 6321610b189b8f22dafc4deac56fcc8c8a34b9e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 07:28:40.973615) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 07:28:40.974095) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 07:28:40.974405) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 07:28:40.989897) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 07:28:40.990311) ========= 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=31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-17 07:28:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 59.7M=0s 2017-01-17 07:28:41 (59.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097324 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 07:28:41.101554) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 07:28:41.101869) ========= 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=31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014957 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 07:28:41.151378) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 07:28:41.151731) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 6321610b189b8f22dafc4deac56fcc8c8a34b9e5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/graphics --rev 6321610b189b8f22dafc4deac56fcc8c8a34b9e5 --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=31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-17 07:28:41,840 truncating revision to first 12 chars 2017-01-17 07:28:41,840 Setting DEBUG logging. 2017-01-17 07:28:41,840 attempt 1/10 2017-01-17 07:28:41,840 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/6321610b189b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-17 07:28:42,150 unpacking tar archive at: graphics-6321610b189b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.622713 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 07:28:41.787918) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 07:28:41.788238) ========= script_repo_revision: 6321610b189b8f22dafc4deac56fcc8c8a34b9e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 07:28:41.788667) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 07:28:41.788962) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 07:28:41.797484) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-01-17 07:28:41.798473) ========= /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=31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:28:42 INFO - MultiFileLogger online at 20170117 07:28:42 in /builds/slave/test 07:28:42 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 07:28:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:28:42 INFO - {'append_to_log': False, 07:28:42 INFO - 'base_work_dir': '/builds/slave/test', 07:28:42 INFO - 'blob_upload_branch': 'Graphics', 07:28:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:28:42 INFO - 'branch': 'Graphics', 07:28:42 INFO - 'buildbot_json_path': 'buildprops.json', 07:28:42 INFO - 'config_files': ('talos/linux_config.py',), 07:28:42 INFO - 'default_actions': ('clobber', 07:28:42 INFO - 'read-buildbot-config', 07:28:42 INFO - 'download-and-extract', 07:28:42 INFO - 'populate-webroot', 07:28:42 INFO - 'create-virtualenv', 07:28:42 INFO - 'install', 07:28:42 INFO - 'run-tests'), 07:28:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:28:42 INFO - 'download_minidump_stackwalk': True, 07:28:42 INFO - 'download_symbols': 'ondemand', 07:28:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:28:42 INFO - 'tooltool.py': '/tools/tooltool.py', 07:28:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:28:42 INFO - '/tools/misc-python/virtualenv.py')}, 07:28:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:28:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:28:42 INFO - 'installer_path': 'installer.exe', 07:28:42 INFO - 'log_level': 'info', 07:28:42 INFO - 'log_name': 'talos', 07:28:42 INFO - 'log_to_console': True, 07:28:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:28:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:28:42 INFO - 'opt_config_files': (), 07:28:42 INFO - 'pip_index': False, 07:28:42 INFO - 'sps_profile': False, 07:28:42 INFO - 'sps_profile_interval': 0, 07:28:42 INFO - 'suite': 'dromaeojs', 07:28:42 INFO - 'system_bits': '32', 07:28:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:28:42 INFO - 'title': 'talos-linux64-ix-014', 07:28:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:28:42 INFO - 'use_talos_json': True, 07:28:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:28:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:28:42 INFO - 'work_dir': 'build'} 07:28:42 INFO - [mozharness: 2017-01-17 15:28:42.578969Z] Running clobber step. 07:28:42 INFO - Running pre-action listener: _resource_record_pre_action 07:28:42 INFO - Running main action method: clobber 07:28:42 INFO - rmtree: /builds/slave/test/build 07:28:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:28:43 INFO - Running post-action listener: _resource_record_post_action 07:28:43 INFO - [mozharness: 2017-01-17 15:28:43.569627Z] Finished clobber step (success) 07:28:43 INFO - [mozharness: 2017-01-17 15:28:43.569727Z] Running read-buildbot-config step. 07:28:43 INFO - Running pre-action listener: _resource_record_pre_action 07:28:43 INFO - Running main action method: read_buildbot_config 07:28:43 INFO - Using buildbot properties: 07:28:43 INFO - { 07:28:43 INFO - "project": "", 07:28:43 INFO - "product": "firefox", 07:28:43 INFO - "who": "nsilva@mozilla.com", 07:28:43 INFO - "installer_path": "public/build/target.tar.bz2", 07:28:43 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 07:28:43 INFO - "repository": "https://hg.mozilla.org/projects/graphics/", 07:28:43 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 07:28:43 INFO - "stage_platform": "linux64", 07:28:43 INFO - "basedir": "/builds/slave/test", 07:28:43 INFO - "buildnumber": 30, 07:28:43 INFO - "platform": "ubuntu64_hw", 07:28:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:28:43 INFO - "slavebuilddir": "test", 07:28:43 INFO - "taskId": "JnoAv7s-RbyGtvZF4p4ZiA", 07:28:43 INFO - "branch": "graphics", 07:28:43 INFO - "script_repo_revision": "default", 07:28:43 INFO - "revision": "6321610b189b8f22dafc4deac56fcc8c8a34b9e5", 07:28:43 INFO - "slavename": "talos-linux64-ix-014", 07:28:43 INFO - "repo_path": "projects/graphics" 07:28:43 INFO - } 07:28:43 INFO - Finding installer, test and symbols from parent task. 07:28:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JnoAv7s-RbyGtvZF4p4ZiA'}, attempt #1 07:28:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JnoAv7s-RbyGtvZF4p4ZiA'}, attempt #1 07:28:44 INFO - Task dependencies: B-YDCAOWQB6ZUweRWluNMg 07:28:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg'}, attempt #1 07:28:45 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.tar.bz2 07:28:45 INFO - Set test_url: https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/test_packages.json 07:28:45 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.crashreporter-symbols.zip 07:28:45 INFO - Running post-action listener: _resource_record_post_action 07:28:45 INFO - [mozharness: 2017-01-17 15:28:45.027933Z] Finished read-buildbot-config step (success) 07:28:45 INFO - [mozharness: 2017-01-17 15:28:45.028153Z] Running download-and-extract step. 07:28:45 INFO - Running pre-action listener: _resource_record_pre_action 07:28:45 INFO - Running main action method: download_and_extract 07:28:45 INFO - mkdir: /builds/slave/test/build/tests 07:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:45 INFO - trying https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.test_packages.json 07:28:45 INFO - Downloading https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:28:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:28:45 INFO - Downloaded 896 bytes. 07:28:45 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:28:45 INFO - Using the following test package requirements: 07:28:45 INFO - {u'common': [u'target.common.tests.zip'], 07:28:45 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:28:45 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:28:45 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:28:45 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:28:45 INFO - u'mozbase': [u'target.common.tests.zip'], 07:28:45 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:28:45 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:28:45 INFO - u'web-platform': [u'target.common.tests.zip', 07:28:45 INFO - u'target.web-platform.tests.zip'], 07:28:45 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:28:45 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:28:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.common.tests.zip 07:28:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:28:45 INFO - Fetch https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.common.tests.zip into memory 07:28:46 INFO - Expected file size: 20273079 07:28:46 INFO - Obtained file size: 20273079 07:28:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:28:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.common.tests.zip 07:28:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:28:50 INFO - Fetch https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.common.tests.zip into memory 07:28:51 INFO - Expected file size: 20273079 07:28:51 INFO - Obtained file size: 20273079 07:28:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.talos.tests.zip 07:28:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:28:55 INFO - Fetch https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.talos.tests.zip into memory 07:28:56 INFO - Expected file size: 14403463 07:28:56 INFO - Obtained file size: 14403463 07:28: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')]} 07:28:56 INFO - trying https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.tar.bz2 07:28:56 INFO - Downloading https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:28:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:28:59 WARNING - URL Error: https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.tar.bz2 07:28:59 INFO - Running command: ['nslookup', 'queue.taskcluster.net'] 07:28:59 INFO - Copy/paste: nslookup queue.taskcluster.net 07:28:59 INFO - Server: 10.26.75.40 07:28:59 INFO - Address: 10.26.75.40#53 07:28:59 INFO - queue.taskcluster.net canonical name = toyama-73636.herokussl.com. 07:28:59 INFO - toyama-73636.herokussl.com canonical name = elb081832-1105536650.us-east-1.elb.amazonaws.com. 07:28:59 INFO - Name: elb081832-1105536650.us-east-1.elb.amazonaws.com 07:28:59 INFO - Address: 107.20.157.107 07:28:59 INFO - Name: elb081832-1105536650.us-east-1.elb.amazonaws.com 07:28:59 INFO - Address: 23.21.44.85 07:28:59 INFO - Name: elb081832-1105536650.us-east-1.elb.amazonaws.com 07:28:59 INFO - Address: 107.21.110.150 07:28:59 INFO - Return code: 0 07:28:59 INFO - retry: attempt #1 caught exception: 07:28:59 INFO - retry: Failed, sleeping 30 seconds before retrying 07:29:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #2 07:29:31 INFO - Downloaded 56145016 bytes. 07:29:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.tar.bz2 07:29:31 INFO - mkdir: /builds/slave/test/properties 07:29:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:29:31 INFO - Writing to file /builds/slave/test/properties/build_url 07:29:31 INFO - Contents: 07:29:31 INFO - build_url:https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.tar.bz2 07:29:31 INFO - Running post-action listener: _resource_record_post_action 07:29:31 INFO - Running post-action listener: set_extra_try_arguments 07:29:31 INFO - [mozharness: 2017-01-17 15:29:31.381426Z] Finished download-and-extract step (success) 07:29:31 INFO - [mozharness: 2017-01-17 15:29:31.381658Z] Running populate-webroot step. 07:29:31 INFO - Running pre-action listener: _resource_record_pre_action 07:29:31 INFO - Running main action method: populate_webroot 07:29:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:29:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:29:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:29:31 INFO - '--tppagecycles', 07:29:31 INFO - '7'], 07:29:31 INFO - 'tests': ['tsvgm']}}, 07:29:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:29:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:29:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:29:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:29:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:29:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:29:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:29:31 INFO - 'talos_options': ['--disable-e10s'], 07:29:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:29:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:29:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:29:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:29:31 INFO - 'talos_options': ['--disable-e10s'], 07:29:31 INFO - 'tests': ['damp', 'tps']}, 07:29:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:29:31 INFO - 'tests': ['damp', 'tps']}, 07:29:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:29:31 INFO - 'tests': ['dromaeo_dom']}, 07:29:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:29:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:29:31 INFO - 'tests': ['basic_compositor_video']}, 07:29:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:29:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:29:31 INFO - 'tests': ['a11yr', 07:29:31 INFO - 'ts_paint', 07:29:31 INFO - 'tpaint', 07:29:31 INFO - 'sessionrestore', 07:29:31 INFO - 'sessionrestore_no_auto_restore', 07:29:31 INFO - 'tabpaint']}, 07:29:31 INFO - 'other-e10s': {'tests': ['a11yr', 07:29:31 INFO - 'ts_paint', 07:29:31 INFO - 'tpaint', 07:29:31 INFO - 'sessionrestore', 07:29:31 INFO - 'sessionrestore_no_auto_restore', 07:29:31 INFO - 'tabpaint']}, 07:29:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:29:31 INFO - 'ts_paint', 07:29:31 INFO - 'tpaint', 07:29:31 INFO - 'sessionrestore', 07:29:31 INFO - 'sessionrestore_no_auto_restore', 07:29:31 INFO - 'tabpaint']}, 07:29:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:29:31 INFO - 'ts_paint', 07:29:31 INFO - 'tpaint', 07:29:31 INFO - 'sessionrestore', 07:29:31 INFO - 'sessionrestore_no_auto_restore', 07:29:31 INFO - 'tabpaint']}, 07:29:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:29:31 INFO - 'tests': ['a11yr', 07:29:31 INFO - 'ts_paint', 07:29:31 INFO - 'tpaint', 07:29:31 INFO - 'sessionrestore', 07:29:31 INFO - 'sessionrestore_no_auto_restore', 07:29:31 INFO - 'tabpaint']}, 07:29:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:29:31 INFO - 'tests': ['a11yr', 07:29:31 INFO - 'ts_paint', 07:29:31 INFO - 'tpaint', 07:29:31 INFO - 'sessionrestore', 07:29:31 INFO - 'sessionrestore_no_auto_restore', 07:29:31 INFO - 'tabpaint']}, 07:29:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:29:31 INFO - 'tests': ['tsvgx', 07:29:31 INFO - 'tsvgr_opacity', 07:29:31 INFO - 'tart', 07:29:31 INFO - 'tscrollx', 07:29:31 INFO - 'cart', 07:29:31 INFO - 'tsvg_static']}, 07:29:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:29:31 INFO - 'tsvgr_opacity', 07:29:31 INFO - 'tart', 07:29:31 INFO - 'tscrollx', 07:29:31 INFO - 'cart', 07:29:31 INFO - 'tsvg_static']}, 07:29:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:29:31 INFO - 'talos_options': ['--disable-e10s'], 07:29:31 INFO - 'tests': ['tp5o']}, 07:29:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:29:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:29:31 INFO - 'talos_options': ['--disable-e10s', 07:29:31 INFO - '--xperf_path', 07:29:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:29:31 INFO - 'tests': ['tp5n']}, 07:29:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:29:31 INFO - 'talos_options': ['--xperf_path', 07:29:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:29:31 INFO - 'tests': ['tp5n']}}, 07:29:31 INFO - 'talos.zip': {'path': '', 07:29:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:29:31 INFO - Running post-action listener: _resource_record_post_action 07:29:31 INFO - [mozharness: 2017-01-17 15:29:31.400446Z] Finished populate-webroot step (success) 07:29:31 INFO - [mozharness: 2017-01-17 15:29:31.400536Z] Running create-virtualenv step. 07:29:31 INFO - Running pre-action listener: _resource_record_pre_action 07:29:31 INFO - Running main action method: create_virtualenv 07:29:31 INFO - Creating virtualenv /builds/slave/test/build/venv 07:29:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:29:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:29:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:29:31 INFO - Using real prefix '/usr' 07:29:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:29:32 INFO - Installing distribute.............................................................................................................................................................................................done. 07:29:33 INFO - Installing pip.................done. 07:29:33 INFO - Return code: 0 07:29:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:29:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:29:34 INFO - Reading from file tmpfile_stdout 07:29:34 INFO - Output received: 07:29:34 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) 07:29:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb13f0>, '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 0x1eb1cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:29:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:29:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:29:34 INFO - Using env: {'DISPLAY': ':0', 07:29:34 INFO - 'HOME': '/home/cltbld', 07:29:34 INFO - 'LANG': 'en_US.UTF-8', 07:29:34 INFO - 'LANGUAGE': 'en_US:en', 07:29:34 INFO - 'LOGNAME': 'cltbld', 07:29:34 INFO - 'MAIL': '/var/mail/cltbld', 07:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:34 INFO - 'MOZ_NO_REMOTE': '1', 07:29:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:34 INFO - 'NO_EM_RESTART': '1', 07:29:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:34 INFO - 'PWD': '/builds/slave/test', 07:29:34 INFO - 'SHELL': '/bin/bash', 07:29:34 INFO - 'SHLVL': '1', 07:29:34 INFO - 'TERM': 'linux', 07:29:34 INFO - 'TMOUT': '86400', 07:29:34 INFO - 'USER': 'cltbld', 07:29:34 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734', 07:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:34 INFO - '_': '/tools/buildbot/bin/python'} 07:29:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:29:34 INFO - Cleaning up... 07:29:34 INFO - Return code: 0 07:29:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb13f0>, '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 0x1eb1cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:29:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:29:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:29:34 INFO - Using env: {'DISPLAY': ':0', 07:29:34 INFO - 'HOME': '/home/cltbld', 07:29:34 INFO - 'LANG': 'en_US.UTF-8', 07:29:34 INFO - 'LANGUAGE': 'en_US:en', 07:29:34 INFO - 'LOGNAME': 'cltbld', 07:29:34 INFO - 'MAIL': '/var/mail/cltbld', 07:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:34 INFO - 'MOZ_NO_REMOTE': '1', 07:29:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:34 INFO - 'NO_EM_RESTART': '1', 07:29:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:34 INFO - 'PWD': '/builds/slave/test', 07:29:34 INFO - 'SHELL': '/bin/bash', 07:29:34 INFO - 'SHLVL': '1', 07:29:34 INFO - 'TERM': 'linux', 07:29:34 INFO - 'TMOUT': '86400', 07:29:34 INFO - 'USER': 'cltbld', 07:29:34 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734', 07:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:34 INFO - '_': '/tools/buildbot/bin/python'} 07:29:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:34 INFO - Downloading/unpacking psutil>=3.1.1 07:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:29:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:29:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:29:36 INFO - Installing collected packages: psutil 07:29:36 INFO - Running setup.py install for psutil 07:29:36 INFO - building 'psutil._psutil_linux' extension 07:29:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:29:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:29:37 INFO - building 'psutil._psutil_posix' extension 07:29:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:29:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:29:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:29:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:29:37 INFO - Successfully installed psutil 07:29:37 INFO - Cleaning up... 07:29:37 INFO - Return code: 0 07:29:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:37 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 0x1b421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb13f0>, '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 0x1eb1cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:29:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:29:37 INFO - Using env: {'DISPLAY': ':0', 07:29:37 INFO - 'HOME': '/home/cltbld', 07:29:37 INFO - 'LANG': 'en_US.UTF-8', 07:29:37 INFO - 'LANGUAGE': 'en_US:en', 07:29:37 INFO - 'LOGNAME': 'cltbld', 07:29:37 INFO - 'MAIL': '/var/mail/cltbld', 07:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:37 INFO - 'MOZ_NO_REMOTE': '1', 07:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:37 INFO - 'NO_EM_RESTART': '1', 07:29:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:37 INFO - 'PWD': '/builds/slave/test', 07:29:37 INFO - 'SHELL': '/bin/bash', 07:29:37 INFO - 'SHLVL': '1', 07:29:37 INFO - 'TERM': 'linux', 07:29:37 INFO - 'TMOUT': '86400', 07:29:37 INFO - 'USER': 'cltbld', 07:29:37 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734', 07:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:37 INFO - '_': '/tools/buildbot/bin/python'} 07:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:29:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:29:39 INFO - Installing collected packages: mozsystemmonitor 07:29:39 INFO - Running setup.py install for mozsystemmonitor 07:29:39 INFO - Successfully installed mozsystemmonitor 07:29:39 INFO - Cleaning up... 07:29:39 INFO - Return code: 0 07:29:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:29:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:39 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 0x1b421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb13f0>, '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 0x1eb1cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:29:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:29:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:29:39 INFO - Using env: {'DISPLAY': ':0', 07:29:39 INFO - 'HOME': '/home/cltbld', 07:29:39 INFO - 'LANG': 'en_US.UTF-8', 07:29:39 INFO - 'LANGUAGE': 'en_US:en', 07:29:39 INFO - 'LOGNAME': 'cltbld', 07:29:39 INFO - 'MAIL': '/var/mail/cltbld', 07:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:39 INFO - 'MOZ_NO_REMOTE': '1', 07:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:39 INFO - 'NO_EM_RESTART': '1', 07:29:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:39 INFO - 'PWD': '/builds/slave/test', 07:29:39 INFO - 'SHELL': '/bin/bash', 07:29:39 INFO - 'SHLVL': '1', 07:29:39 INFO - 'TERM': 'linux', 07:29:39 INFO - 'TMOUT': '86400', 07:29:39 INFO - 'USER': 'cltbld', 07:29:39 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734', 07:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:39 INFO - '_': '/tools/buildbot/bin/python'} 07:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:39 INFO - Downloading/unpacking jsonschema==2.5.1 07:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:29:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29:42 INFO - Downloading functools32-3.2.3-2.tar.gz 07:29:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:29:42 INFO - warning: no files found matching '*.txt' 07:29:42 INFO - no previously-included directories found matching 'build' 07:29:42 INFO - no previously-included directories found matching 'dist' 07:29:42 INFO - no previously-included directories found matching '.git*' 07:29:42 INFO - Installing collected packages: jsonschema, functools32 07:29:42 INFO - Running setup.py install for functools32 07:29:42 INFO - warning: no files found matching '*.txt' 07:29:42 INFO - no previously-included directories found matching 'build' 07:29:42 INFO - no previously-included directories found matching 'dist' 07:29:42 INFO - no previously-included directories found matching '.git*' 07:29:42 INFO - Successfully installed jsonschema functools32 07:29:42 INFO - Cleaning up... 07:29:42 INFO - Return code: 0 07:29:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:42 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 0x1b421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb13f0>, '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 0x1eb1cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:29:42 INFO - Using env: {'DISPLAY': ':0', 07:29:42 INFO - 'HOME': '/home/cltbld', 07:29:42 INFO - 'LANG': 'en_US.UTF-8', 07:29:42 INFO - 'LANGUAGE': 'en_US:en', 07:29:42 INFO - 'LOGNAME': 'cltbld', 07:29:42 INFO - 'MAIL': '/var/mail/cltbld', 07:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:42 INFO - 'MOZ_NO_REMOTE': '1', 07:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:42 INFO - 'NO_EM_RESTART': '1', 07:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:42 INFO - 'PWD': '/builds/slave/test', 07:29:42 INFO - 'SHELL': '/bin/bash', 07:29:42 INFO - 'SHLVL': '1', 07:29:42 INFO - 'TERM': 'linux', 07:29:42 INFO - 'TMOUT': '86400', 07:29:42 INFO - 'USER': 'cltbld', 07:29:42 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734', 07:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:42 INFO - '_': '/tools/buildbot/bin/python'} 07:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:29:42 INFO - Cleaning up... 07:29:42 INFO - Return code: 0 07:29:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:42 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 0x1b421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb13f0>, '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 0x1eb1cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:29:42 INFO - Using env: {'DISPLAY': ':0', 07:29:42 INFO - 'HOME': '/home/cltbld', 07:29:42 INFO - 'LANG': 'en_US.UTF-8', 07:29:42 INFO - 'LANGUAGE': 'en_US:en', 07:29:42 INFO - 'LOGNAME': 'cltbld', 07:29:42 INFO - 'MAIL': '/var/mail/cltbld', 07:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:42 INFO - 'MOZ_NO_REMOTE': '1', 07:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:42 INFO - 'NO_EM_RESTART': '1', 07:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:42 INFO - 'PWD': '/builds/slave/test', 07:29:42 INFO - 'SHELL': '/bin/bash', 07:29:42 INFO - 'SHLVL': '1', 07:29:42 INFO - 'TERM': 'linux', 07:29:42 INFO - 'TMOUT': '86400', 07:29:42 INFO - 'USER': 'cltbld', 07:29:42 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734', 07:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:42 INFO - '_': '/tools/buildbot/bin/python'} 07:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:42 INFO - Downloading/unpacking blobuploader==1.2.4 07:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:45 INFO - Downloading blobuploader-1.2.4.tar.gz 07:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:29:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:29:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:45 INFO - Downloading docopt-0.6.1.tar.gz 07:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:29:46 INFO - Installing collected packages: blobuploader, requests, docopt 07:29:46 INFO - Running setup.py install for blobuploader 07:29:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:29:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:29:46 INFO - Running setup.py install for requests 07:29:46 INFO - Running setup.py install for docopt 07:29:46 INFO - Successfully installed blobuploader requests docopt 07:29:46 INFO - Cleaning up... 07:29:46 INFO - Return code: 0 07:29:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29: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')]} 07:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29: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')]} 07:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:46 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 0x1b421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb13f0>, '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 0x1eb1cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:29:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:29:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:29:46 INFO - Using env: {'DISPLAY': ':0', 07:29:46 INFO - 'HOME': '/home/cltbld', 07:29:46 INFO - 'LANG': 'en_US.UTF-8', 07:29:46 INFO - 'LANGUAGE': 'en_US:en', 07:29:46 INFO - 'LOGNAME': 'cltbld', 07:29:46 INFO - 'MAIL': '/var/mail/cltbld', 07:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:46 INFO - 'MOZ_NO_REMOTE': '1', 07:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:46 INFO - 'NO_EM_RESTART': '1', 07:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:46 INFO - 'PWD': '/builds/slave/test', 07:29:46 INFO - 'SHELL': '/bin/bash', 07:29:46 INFO - 'SHLVL': '1', 07:29:46 INFO - 'TERM': 'linux', 07:29:46 INFO - 'TMOUT': '86400', 07:29:46 INFO - 'USER': 'cltbld', 07:29:46 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734', 07:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:46 INFO - '_': '/tools/buildbot/bin/python'} 07:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:29:46 INFO - Running setup.py (path:/tmp/pip-dYX5Tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:29:46 INFO - Running setup.py (path:/tmp/pip-X0TLE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:29:47 INFO - Running setup.py (path:/tmp/pip-GCGMtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:29:47 INFO - Running setup.py (path:/tmp/pip-AEaTX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:29:47 INFO - Running setup.py (path:/tmp/pip-Ly_wH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:29:47 INFO - Running setup.py (path:/tmp/pip-3Ri_dS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:29:47 INFO - Running setup.py (path:/tmp/pip-r92d4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:29:47 INFO - Running setup.py (path:/tmp/pip-5Hodge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:29:47 INFO - Running setup.py (path:/tmp/pip-k9cjUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:29:47 INFO - Running setup.py (path:/tmp/pip-JLUxCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:29:47 INFO - Running setup.py (path:/tmp/pip-lwRDWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:29:47 INFO - Running setup.py (path:/tmp/pip-2s5EyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:29:47 INFO - Running setup.py (path:/tmp/pip-k1bC7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:29:47 INFO - Running setup.py (path:/tmp/pip-PUqHzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:47 INFO - Running setup.py (path:/tmp/pip-NIhhRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:29:47 INFO - Running setup.py (path:/tmp/pip-Mp9nj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:29:48 INFO - Running setup.py (path:/tmp/pip-Mih93w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:29:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:29:48 INFO - Running setup.py install for manifestparser 07:29:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:29:48 INFO - Running setup.py install for mozcrash 07:29:48 INFO - Running setup.py install for mozdebug 07:29:48 INFO - Running setup.py install for mozdevice 07:29:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:29:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:29:48 INFO - Running setup.py install for mozfile 07:29:48 INFO - Running setup.py install for mozhttpd 07:29:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:29:48 INFO - Running setup.py install for mozinfo 07:29:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:29:48 INFO - Running setup.py install for mozInstall 07:29:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:29:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:29:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:29:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:29:48 INFO - Running setup.py install for mozleak 07:29:48 INFO - Running setup.py install for mozlog 07:29:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:29:49 INFO - Running setup.py install for moznetwork 07:29:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:29:49 INFO - Running setup.py install for mozprocess 07:29:49 INFO - Running setup.py install for mozprofile 07:29:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:29:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:29:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:29:49 INFO - Running setup.py install for mozrunner 07:29:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:29:49 INFO - Running setup.py install for mozscreenshot 07:29:49 INFO - Running setup.py install for moztest 07:29:49 INFO - Running setup.py install for mozversion 07:29:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:29:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:29:49 INFO - Cleaning up... 07:29:49 INFO - Return code: 0 07:29:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:49 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 0x1b421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb13f0>, '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 0x1eb1cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:29:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:29:49 INFO - Using env: {'DISPLAY': ':0', 07:29:49 INFO - 'HOME': '/home/cltbld', 07:29:49 INFO - 'LANG': 'en_US.UTF-8', 07:29:49 INFO - 'LANGUAGE': 'en_US:en', 07:29:49 INFO - 'LOGNAME': 'cltbld', 07:29:49 INFO - 'MAIL': '/var/mail/cltbld', 07:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:49 INFO - 'MOZ_NO_REMOTE': '1', 07:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:49 INFO - 'NO_EM_RESTART': '1', 07:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:49 INFO - 'PWD': '/builds/slave/test', 07:29:49 INFO - 'SHELL': '/bin/bash', 07:29:49 INFO - 'SHLVL': '1', 07:29:49 INFO - 'TERM': 'linux', 07:29:49 INFO - 'TMOUT': '86400', 07:29:49 INFO - 'USER': 'cltbld', 07:29:49 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734', 07:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:49 INFO - '_': '/tools/buildbot/bin/python'} 07:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:29:50 INFO - Running setup.py (path:/tmp/pip-MkzL9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:29:50 INFO - Running setup.py (path:/tmp/pip-sYmAO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:29:50 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)) 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:29:50 INFO - Running setup.py (path:/tmp/pip-dDPqdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:29:50 INFO - Running setup.py (path:/tmp/pip-PeNCqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:29:50 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)) 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:29:50 INFO - Running setup.py (path:/tmp/pip-pUrCon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:29:50 INFO - Running setup.py (path:/tmp/pip-3O1LGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:29:50 INFO - Running setup.py (path:/tmp/pip-dS7Tt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:29:50 INFO - Running setup.py (path:/tmp/pip-8pWNKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:29:50 INFO - Running setup.py (path:/tmp/pip-KA128M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:29:50 INFO - Running setup.py (path:/tmp/pip-IpzCva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:29:50 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)) 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:29:50 INFO - Running setup.py (path:/tmp/pip-8nb8cU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:29:50 INFO - Running setup.py (path:/tmp/pip-yON3YB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:29:51 INFO - Running setup.py (path:/tmp/pip-y8PvwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:29:51 INFO - Running setup.py (path:/tmp/pip-uV2eEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:29:51 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)) 07:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:51 INFO - Running setup.py (path:/tmp/pip-8IgBOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:29:51 INFO - Running setup.py (path:/tmp/pip-pioQ02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:29:51 INFO - Running setup.py (path:/tmp/pip-A1Gua3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:29:51 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)) 07:29:51 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)) 07:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:29:51 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)) 07:29:51 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)) 07:29:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29:53 INFO - Downloading blessings-1.6.tar.gz 07:29:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:29:53 INFO - Installing collected packages: blessings 07:29:53 INFO - Running setup.py install for blessings 07:29:53 INFO - Successfully installed blessings 07:29:53 INFO - Cleaning up... 07:29:53 INFO - Return code: 0 07:29:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:29:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:29:53 INFO - Reading from file tmpfile_stdout 07:29:53 INFO - Current package versions: 07:29:53 INFO - argparse == 1.2.1 07:29:53 INFO - blessings == 1.6 07:29:53 INFO - blobuploader == 1.2.4 07:29:53 INFO - docopt == 0.6.1 07:29:53 INFO - functools32 == 3.2.3-2 07:29:53 INFO - jsonschema == 2.5.1 07:29:53 INFO - manifestparser == 1.1 07:29:53 INFO - mozInstall == 1.12 07:29:53 INFO - mozcrash == 1.0 07:29:53 INFO - mozdebug == 0.1 07:29:53 INFO - mozdevice == 0.49 07:29:53 INFO - mozfile == 1.2 07:29:53 INFO - mozhttpd == 0.7 07:29:53 INFO - mozinfo == 0.9 07:29:53 INFO - mozleak == 0.1 07:29:53 INFO - mozlog == 3.4 07:29:53 INFO - moznetwork == 0.27 07:29:53 INFO - mozprocess == 0.24 07:29:53 INFO - mozprofile == 0.28 07:29:53 INFO - mozrunner == 6.13 07:29:53 INFO - mozscreenshot == 0.1 07:29:53 INFO - mozsystemmonitor == 0.3 07:29:53 INFO - moztest == 0.8 07:29:53 INFO - mozversion == 1.4 07:29:53 INFO - psutil == 3.1.1 07:29:53 INFO - requests == 1.2.3 07:29:53 INFO - wsgiref == 0.1.2 07:29:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:53 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 0x1b421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb13f0>, '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 0x1eb1cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:29:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:29:53 INFO - Using env: {'DISPLAY': ':0', 07:29:53 INFO - 'HOME': '/home/cltbld', 07:29:53 INFO - 'LANG': 'en_US.UTF-8', 07:29:53 INFO - 'LANGUAGE': 'en_US:en', 07:29:53 INFO - 'LOGNAME': 'cltbld', 07:29:53 INFO - 'MAIL': '/var/mail/cltbld', 07:29:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:53 INFO - 'MOZ_NO_REMOTE': '1', 07:29:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:53 INFO - 'NO_EM_RESTART': '1', 07:29:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:53 INFO - 'PWD': '/builds/slave/test', 07:29:53 INFO - 'SHELL': '/bin/bash', 07:29:53 INFO - 'SHLVL': '1', 07:29:53 INFO - 'TERM': 'linux', 07:29:53 INFO - 'TMOUT': '86400', 07:29:53 INFO - 'USER': 'cltbld', 07:29:53 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734', 07:29:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:53 INFO - '_': '/tools/buildbot/bin/python'} 07:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:29:54 INFO - Cleaning up... 07:29:54 INFO - Return code: 0 07:29:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:54 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 0x1b421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb13f0>, '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 0x1eb1cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:29:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:29:54 INFO - Using env: {'DISPLAY': ':0', 07:29:54 INFO - 'HOME': '/home/cltbld', 07:29:54 INFO - 'LANG': 'en_US.UTF-8', 07:29:54 INFO - 'LANGUAGE': 'en_US:en', 07:29:54 INFO - 'LOGNAME': 'cltbld', 07:29:54 INFO - 'MAIL': '/var/mail/cltbld', 07:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:54 INFO - 'MOZ_NO_REMOTE': '1', 07:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:54 INFO - 'NO_EM_RESTART': '1', 07:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:54 INFO - 'PWD': '/builds/slave/test', 07:29:54 INFO - 'SHELL': '/bin/bash', 07:29:54 INFO - 'SHLVL': '1', 07:29:54 INFO - 'TERM': 'linux', 07:29:54 INFO - 'TMOUT': '86400', 07:29:54 INFO - 'USER': 'cltbld', 07:29:54 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734', 07:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:54 INFO - '_': '/tools/buildbot/bin/python'} 07:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:29:54 INFO - Cleaning up... 07:29:54 INFO - Return code: 0 07:29:54 INFO - Running post-action listener: _resource_record_post_action 07:29:54 INFO - Running post-action listener: _start_resource_monitoring 07:29:54 INFO - Starting resource monitoring. 07:29:54 INFO - [mozharness: 2017-01-17 15:29:54.343616Z] Finished create-virtualenv step (success) 07:29:54 INFO - [mozharness: 2017-01-17 15:29:54.344135Z] Running install step. 07:29:54 INFO - Running pre-action listener: _resource_record_pre_action 07:29:54 INFO - Running main action method: install 07:29:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:29:54 INFO - Reading from file tmpfile_stdout 07:29:54 INFO - Detecting whether we're running mozinstall >=1.0... 07:29:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:29:54 INFO - Reading from file tmpfile_stdout 07:29:54 INFO - Output received: 07:29:54 INFO - Usage: mozinstall [options] installer 07:29:54 INFO - Options: 07:29:54 INFO - -h, --help show this help message and exit 07:29:54 INFO - -d DEST, --destination=DEST 07:29:54 INFO - Directory to install application into. [default: 07:29:54 INFO - "/builds/slave/test"] 07:29:54 INFO - --app=APP Application being installed. [default: firefox] 07:29:54 INFO - mkdir: /builds/slave/test/build/application 07:29:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:30:10 INFO - Reading from file tmpfile_stdout 07:30:10 INFO - Output received: 07:30:10 INFO - /builds/slave/test/build/application/firefox/firefox 07:30:10 INFO - Running post-action listener: _resource_record_post_action 07:30:10 INFO - [mozharness: 2017-01-17 15:30:10.898049Z] Finished install step (success) 07:30:10 INFO - [mozharness: 2017-01-17 15:30:10.898323Z] Running run-tests step. 07:30:10 INFO - Running pre-action listener: _resource_record_pre_action 07:30:10 INFO - Running main action method: run_tests 07:30:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:30:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:30:10 INFO - Python 2.7.3 07:30:10 INFO - Return code: 0 07:30:10 INFO - grabbing minidump binary from tooltool 07:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:10 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 0x1eb13f0>, '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 0x1eb1cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:30:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:30:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:30:10 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:30:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:30:10 INFO - Return code: 0 07:30:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:30:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:30:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:30:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:30:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:30:10 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/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:30:10 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/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:30:10 INFO - Using env: {'DISPLAY': ':0', 07:30:10 INFO - 'HOME': '/home/cltbld', 07:30:10 INFO - 'LANG': 'en_US.UTF-8', 07:30:10 INFO - 'LANGUAGE': 'en_US:en', 07:30:10 INFO - 'LOGNAME': 'cltbld', 07:30:10 INFO - 'MAIL': '/var/mail/cltbld', 07:30:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:30:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:10 INFO - 'MOZ_NO_REMOTE': '1', 07:30:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:30:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:10 INFO - 'NO_EM_RESTART': '1', 07:30:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:10 INFO - 'PWD': '/builds/slave/test', 07:30:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:30:10 INFO - 'SHELL': '/bin/bash', 07:30:10 INFO - 'SHLVL': '1', 07:30:10 INFO - 'TERM': 'linux', 07:30:10 INFO - 'TMOUT': '86400', 07:30:10 INFO - 'USER': 'cltbld', 07:30:10 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734', 07:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:10 INFO - '_': '/tools/buildbot/bin/python'} 07:30:10 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/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:30:11 INFO - mozversion application_buildid: 20170117145405 07:30:11 INFO - mozversion application_changeset: 6321610b189b8f22dafc4deac56fcc8c8a34b9e5 07:30:11 INFO - mozversion application_display_name: Nightly 07:30:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:30:11 INFO - mozversion application_name: Firefox 07:30:11 INFO - mozversion application_remotingname: firefox 07:30:11 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 07:30:11 INFO - mozversion application_vendor: Mozilla 07:30:11 INFO - mozversion application_version: 53.0a1 07:30:11 INFO - mozversion platform_buildid: 20170117145405 07:30:11 INFO - mozversion platform_changeset: 6321610b189b8f22dafc4deac56fcc8c8a34b9e5 07:30:11 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 07:30:11 INFO - mozversion platform_version: 53.0a1 07:30:11 INFO - using testdate: 1484667011 07:30:11 INFO - actual date: 1484667011 07:30:11 INFO - starting webserver on 'localhost:34754' 07:30:11 INFO - SUITE-START | Running 2 tests 07:30:11 INFO - TEST-START | dromaeo_css 07:30:11 INFO - operating with platform_type : linux_ 07:30:11 INFO - Initialising browser for dromaeo_css test... 07:30:11 INFO - TEST-INFO | started process 12777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNYqOmE/profile http://localhost:34754/getInfo.html) 07:30:15 INFO - PROCESS | 12777 | __metrics Screen width/height:1600/1200 07:30:15 INFO - PROCESS | 12777 | colorDepth:24 07:30:15 INFO - PROCESS | 12777 | Browser inner width/height: 1024/697 07:30:15 INFO - PROCESS | 12777 | __metrics 07:30:15 INFO - PROCESS | 12777 | 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" 07:30:15 INFO - PROCESS | 12777 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:30:16 INFO - PROCESS | 12777 | console.error: PushService: 07:30:16 INFO - PROCESS | 12777 | stateChangeProcessEnqueue: Error transitioning state 07:30:16 INFO - PROCESS | 12777 | UnknownError 07:30:16 INFO - TEST-INFO | 12777: exit 0 07:30:16 INFO - Browser initialized. 07:30:16 INFO - Running cycle 1/1 for dromaeo_css test... 07:30:16 INFO - TEST-INFO | started process 12858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNYqOmE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:30:28 INFO - PROCESS | 12858 | RSS: Main: 152047616 07:30:28 INFO - PROCESS | 12858 | 07:33:34 INFO - PROCESS | 12858 | Cycle 1(1): loaded http://localhost:34754/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34754/tests/dromaeo/cssquery-ext.html) 07:33:35 INFO - PROCESS | 12858 | RSS: Main: 242331648 07:33:35 INFO - PROCESS | 12858 | 07:35:18 INFO - PROCESS | 12858 | ************************* 07:35:18 INFO - PROCESS | 12858 | A coding exception was thrown and uncaught in a Task. 07:35:18 INFO - PROCESS | 12858 | 07:35:18 ERROR - PROCESS | 12858 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:35:18 INFO - PROCESS | 12858 | Full stack: 07:35:18 INFO - PROCESS | 12858 | ************************* 07:36:37 INFO - PROCESS | 12858 | Cycle 1(1): loaded http://localhost:34754/tests/dromaeo/cssquery-ext.html (next: http://localhost:34754/tests/dromaeo/cssquery-jquery.html) 07:36:38 INFO - PROCESS | 12858 | RSS: Main: 240459776 07:36:38 INFO - PROCESS | 12858 | 07:39:40 INFO - PROCESS | 12858 | Cycle 1(1): loaded http://localhost:34754/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34754/tests/dromaeo/cssquery-mootools.html) 07:39:41 INFO - PROCESS | 12858 | RSS: Main: 184868864 07:39:41 INFO - PROCESS | 12858 | 07:42:43 INFO - PROCESS | 12858 | Cycle 1(1): loaded http://localhost:34754/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34754/tests/dromaeo/cssquery-prototype.html) 07:42:44 INFO - PROCESS | 12858 | RSS: Main: 185131008 07:42:44 INFO - PROCESS | 12858 | 07:45:47 INFO - PROCESS | 12858 | Cycle 1(1): loaded http://localhost:34754/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34754/tests/dromaeo/cssquery-yui.html) 07:45:48 INFO - PROCESS | 12858 | RSS: Main: 185712640 07:45:48 INFO - PROCESS | 12858 | 07:48:51 INFO - PROCESS | 12858 | Cycle 1(1): loaded http://localhost:34754/tests/dromaeo/cssquery-yui.html (next: http://localhost:34754/tests/dromaeo/cssquery-dojo.html) 07:48:51 INFO - PROCESS | 12858 | RSS: Main: 282976256 07:48:51 INFO - PROCESS | 12858 | 07:48:51 INFO - PROCESS | 12858 | __start_tp_report 07:48:51 INFO - PROCESS | 12858 | _x_x_mozilla_page_load 07:48:51 INFO - PROCESS | 12858 | _x_x_mozilla_page_load_details 07:48:51 INFO - PROCESS | 12858 | |i|pagename|runs| 07:48:51 INFO - PROCESS | 12858 | |0;dojo.html;2537.3402915242036;2541.5552278351283;2568.9614655780156;2570.7429257074295;2571.6399704041437;4676.859694209171;4735.597474214687;4752.904941901164;4786.282057691348;4798.136335459616;4748.264019077049;4750.121227572901;4751.311059896313;4774.80900763969;4792.329073929653;4308.80610372534;4351.586599273064;4353.129374125172;4369.563043695637;4398.076403955173;4449.087936972929;4456.175607512604;4460.420145381096;4479.619232365253;4484.304932735415;4316.028893498969;4342.69601127918;4373.322135069069;4375.343698445226;4397.208502469554;4357.7385356878685;4371.409859668967;4373.322135069069;4426.889327766799;4437.4896886858105;4351.6953813233085;4360.236958532244;4368.017196130877;4386.978065109686;4393.340998850166;4642.419697537808;4681.391419115527;4729.101470720552;4784.354112194878;4785.593224575915;5027.421846487664;5046.84859454217;5060.620453466005;5098.056859481007;5127.974360128175;5106.055379754757;5108.846734597968;5125.179971204627;5130.271286596835;5177.275181474596;4666.65000124992;4778.832740854088;4786.545278198566;4789.808407663724;4825.179719447702;5197.688138711689;5198.844034678966;5211.348581427322;5214.713190774544;5218.843434696889;4991.750412479361;5084.618653600995;5098.923516147261;5106.234064890222;5110.66780659256;4991.975040124777;5002.59979201663;5007.098722229961;5074.898502029939;5207.010667973073;5001.89996200074;5002.474740152305;5044.495550444926;5045.369328833895;5049.01544198885;4985.476524964899;5001.899962000813;5011.198208286657;5053.9241911371355;5055.696658200446;4348.782560871944;4351.782410879507;4360.825566977349;4361;4405.537418571068;3720.516332876709;3725.981370093132;3736;3750.7374483785875;3777.9433308500393;4366.279563871989;4377.562243775661;4395.516493185747;4414.426124603781;4414.690971631955;5119.820806271762;5125.33370661819;5126.641135120506;5133.435322114565;5135.717535535581;4252.787360631956;4281.079567892918;4307.6338511226895;4369.890752731144;4380.6057454829215;4598.356230127785;4655.371524844103;4664.043871006435;4684.273937539687;4690.296455531698;4654.790534426027;4656.092062047868;4658.068386322817;4658.417697787777;4697.295405689174;5139.8458046258675;5139.997700448376;5145.742712864417;5146.639735218499;5191.402988656202;4519.118771839459;4564.520725323793;4609.746463944515;4624.1676498230645;4650.232711602548;5055.469175736494;5056.84829455117;5058.241263810458;5058.671186372874;5096.311997880239;5106.157484015096;5142.820001299937;5158.716270605153;5161.200013997836;5193.68837869729;4818.204996175592;4849.781759820746;4952.826651067196;4968.552830245295;5004.274380214922;4982.4768399317545;5019.0463811875625;5025.271335656383;5045.596352291735;5060.974695126501;4820.566149046603;4838.927416088691;4841.05599408112;4941.975290123526;4998.6750861193905;4968.205087186033;4985.401751789664;4988.02733466985;4988.625853060962;5001.149804533311;4693.859184224479;4764.332993380999;4772.0694464580465;4777.689450185727;4879.146149423907 07:48:51 INFO - PROCESS | 12858 | |1;ext.html;520.3989392251949;535.3522238091908;543.8667526456019;561.1582626060908;581.107999221195;29860.402791944147;45281.54718452814;46801;46849.53150468494;47052.76473617627;41417.7929110354;41715.37426938591;41754;41757.58242417575;41760.37359439611;7716.151223365426;7874.094479134916;7891.289783919446;7893.526388416684;7899.3680505559705;7584.241575842427;7802;9922.603095876157;10126.645567405143;10153.136983356424;10180.745481362988;10217.642382516577;10254.897451025507;10257.281990260684;10263.178945684365;9959.25305602079;10008.79982400348;10010.849837252446;10024.849627255597;10029.097381235651;10063.496825158785;10134.13859821916;10140.797184056277;10141.898581014242;10150.340227885164;38599.8070009651;38910.805445972874;38915;38957.80521097376;38959.41560876589;3578.3380074686265;3687.3731465650635;3690.3541880171133;3723.1622884850963;3728.5152930119184;26380.86809565959;26505.204843854714;27623.09422644339;29919;31433.528497072562;3307.1236122427576;3391.1522119470133;3423.246885685145;3543.6102028776813;3546.9113272168142;254124;254358;254987;255314;255814;48185;48801;48807.26789098166;48945;49014;49952.500474994784;50037;50113.498865011614;50116.749416252685;50269;11329.923657252548;11410.714732131763;11419.37193454368;11421.42892855354;11423.600173993871;7915.287624113742;8102.189781021851;9249.075092490697;9267.582958766872;9274.072592740808;15531.767023494656;16048.598785030468;16218.75671864923;16566.420175293806;16594.419195328104;6662.533622646368;6841.931580684229;6888.931110688829;6901.309869013058;6949.270326615733;818.3494122172887;834.8163404051099;835.7492752174323;844.5650489997656;859.7678626770737;27249.31876703098;27818.02636907739;28358.43283134367;28839.134825955254;28935.85532072326;991.7966816802539;994.4033579852031;998.7203582996773;1006.8036732837173;1117.8882111788755;15184.772228416583;15215.923920380328;15292.923535382251;15400.922995384952;15532.611684707746;357091;359714;360181;360693;360772;52195.17072439088;52812.20781688278;52845.7357713209;52905.47094529006;53000.20499692508;1194.62173599944;1199.8200269959402;1240.49759847262;1246.1526162209784;1254.328934020313;26306.816193270966;27352.17943461699;27481.015252788635;28111.57832632553;28145.296367590156;37687.62312376841;42576.361354580324;43549.56450435455;43667.56332436635;48849.75575122102;340119;343406;343711;344015;344871;28931.56602651004;29810;34938;35153.47269790904;35429.05140217313;40670.38994415145;40739;41012.58987410207;41129.79435102805;42380;31744.36511269808;32068.51897221497;32142.357152856344;32199.356012879143;32211.838940805144;31615.84192079117;32014.199645009063;32071.198220044687;32122.19694507656;33104.1723956903;30951.380972380877;31372.686273136977;31680.207994800316;31722.841385792923;32151;27627.585586216625;28351;29273;29354;29388.11835644934;22251.332460026224;22571.210007649654;23032.769672303733;23095.88452057729;23171.768282317636 07:48:51 INFO - PROCESS | 12858 | |2;jquery.html;347.32445393709247;375.81585023338556;376.55566431610725;381.2394273424518;396.7361704466528;13462.394192261347;13524.323783810807;18044.278228870844;18051.909740451312;18086.638267234648;17173.570660733487;17230.396936107238;17495.650086998252;17787.911060444712;17826.46520604384;3835.520559930009;5018.146915024446;5203.765830537616;5206.739663016853;5213.478652134794;4023.6982226333;5972.492338151263;6206.627602343851;6242.282137554194;6375.872482550346;6071.63570185788;6213.56505044647;6297.2128483939505;6310.4320611144985;6312.621242725429;6043.3956604339655;6068.57519973602;6069.969650151743;6072.574919755619;6077.574569780118;5223.268742376071;5334.653247538898;5370.275012873251;5371.301730774974;5378.784848606051;18167.728259021875;18253;19318.71021934672;21214.257500987547;21441.785582144134;2222.355516900097;2245.6406974884103;2259.7514273430074;2261.0729600863565;2338.6024375856146;12876.742465150644;13608.455661773616;13632.93183534076;14181.078229915023;14224.146551206857;1500.6023403798001;1558.8674962628077;1600.43184669443;1842.6314737052644;1914.3586898388917;54591.72704136494;63865;66367.33632663659;75039.24960750378;75065.24934750637;10368;10418.895811041944;10528.473576321154;10735.316170957261;10808.297460665031;14718.484853030093;14737.11577305365;14755.483558075415;14763.33564989578;14775.92612036933;6571.605703657796;6752.696128674222;6796.966015169992;6903.171619405603;6934.306569343126;6156.538259630545;6201.286852012076;6360.745570177141;6366.618002919747;6368.235811702625;4489.147062058199;4494.584205975108;4518.570735780096;4540.205464043779;4649.721016739007;1799.839103778056;1877.9248929932228;1916.5112896211376;1929.4211736479;1935.6902895536646;759.6695437484601;781.3631890009624;784.8234147316922;791.8930944322443;797.2415442568662;16623.418180363627;16682.499525014027;16767;17298.82701172972;17450.563735906704;806.0247101007847;807.2049031703767;811.4279432999721;811.6023148657116;819;9577.664781732745;9897.25770567196;9957.352772069793;9997.600095996224;10142.645007424704;318733;320404;320811;476547;477295;93076.53461732648;93492;97689.51155244178;97921;102194;833.4790755777639;834.9582520874053;865.9437136586101;867.3711559119714;868.2836659755727;15477.303521341342;15507.379704811681;15846;16449.25978330954;16765.245563949895;36254.093647657966;39740.205195896495;40348.31931933913;41980.79009604932;42202.36696449494;50668;53984.460155397945;54471.72764136154;55176.72411637916;55383.16925246044;7079.8938015930835;7247.04283887474;7305.452091093083;7408.962955185405;7687.192844751221;9907.950460247652;9910.35582687123;10626.52180651888;11284.548618055185;11335.886641133484;9288.953555232181;9384.67153649619;9409.341346105706;9439.905600944177;9545.061978004402;9551.856722149312;10222.948885255526;10392.740181495523;10428.843567346345;10581;9635.470049147365;9819.705408837746;9897.604095836086;10203.693889183336;10250.641227557;7280.708771649075;7437.367823735043;7600.087989441303;7605.6577454015805;7685.961570192113;9002.369834111549;9901.801963960537;9947.303688741718;9982.301238913496;10285.640002599874 07:48:51 INFO - PROCESS | 12858 | |3;mootools.html;1302.8406115170712;1320.584016034949;1332.8800407963283;1346.3133801761098;1346.7777816660246;6539.378759017897;6872.9312706872915;6908.585484870899;6920.204176519702;6926.757563485279;5926;6147.538934579902;6429.517786166033;6639.73441062357;6641.335866413357;2136.861104028241;2168.4145280774183;2175.184305885293;2176.6082105221053;2177.096504950444;2093.905774240155;2134.8932553372347;2140.411386868608;2141.4004078857865;2146.742390913085;1869.6447674941785;1935.158206180309;2095.538981424092;2139.0267428320076;2170.0560256288486;2163.5889181055627;2169.5660867826496;2169.6962425260476;2175.369142948551;2175.7715439878743;2069.906854191565;2085.1763553396477;2093.037202886674;2112.8837913914726;2118.756343020557;6626.271110177877;6682.365175308338;6689.93310066898;6696.799096027127;6699.39705426514;4001.6198461146146;4107.363358679379;4108;4109.2808758467445;4111.075008123148;2678.6785585729644;2873.6695280042854;2876.2665520292403;2925.151706005256;2939.162338733472;1045.2265323660513;1090.1006669497617;1100.5267734874;1108.1356541897333;1130.7964566378048;8836.116388361177;8899;8905.109489051109;8913.866292005625;8932.151445612657;3784.4890939723336;4000.099977505038;4048.6963477739287;4064.349704047338;4076.2458945095254;7785.338246249019;7794.961025194951;7798.649060792278;7802.609869506502;7802.921970780333;4286.271333873249;4299;4301.827926882952;4306.82772689089;4311.762853043113;3399.337129259771;3515.4023815950836;3762.62373762627;3808.9047773805323;3882.3400021996326;3290.44062509374;3313.2710803623163;3444.844981975817;3453.7582369234415;3457.360388328167;1181.161375423459;1216.3431746856775;1220.2434490615874;1223.5839814462947;1225.503671013241;720.8738470767595;735.1839458201392;752.5221484357472;760.642498025938;767.3745897093851;4320.243957307459;4634.629229661619;4777.498362671939;4783.928241076386;4914.410270767459;809.7773112394021;825.7564018614523;828.0187977246861;831.0484495252902;854.9273311768445;3023.89416370426;3056.0831750474767;3092.489739193053;3110.9533356999664;3173.6667649896426;7863.292303692695;8087.353011759045;8102.39232057598;8174.427790054639;8210.753677389688;8027.1972802719265;8135.186481351936;8145.877811832827;8152.144024877421;8157.592120393957;6371.267304260069;6419.839504012437;6431.29255781873;6480.481561474976;6492.902606460907;4441.20058389493;4486.798094085709;4553.408056952708;4561.954380456153;4677.3451716759;7119.935218786494;7210.459215558959;7322.414206863332;7346.632668366454;7494.775156745306;7465.477416580788;7504.812379690333;7552.924470755442;7569.962150189434;7590.127135379502;5303.973480132575;5519.724013799214;5628.4090170533145;5790.971045144747;5791.362950075404;6073.726682299219;6224.9377506224355;6276.340984196776;6415.294317624965;6432.067350234096;5457.317835270591;5519.3652729936575;5534.142207957773;5594.608377413542;5645.576581756467;5732.684702341411;5775.884482310415;5785.132230165509;5796.797112101056;5889.911651325319;5102.668326558762;5106.310648062464;5117.795288188431;5147.6654017488745;5174.042802081627;3836.7889766063136;3885.4948856648457;3895.2599006188734;3930.4104384342577;3936.645701886844;3939.1727737175515;3940.5665376807956;3962.782046987443;4043.595640435933;4052.311107111739 07:48:51 INFO - PROCESS | 12858 | |4;prototype.html;350.2277478160655;354.46475821509523;358.8528703231674;364.25509832392754;370.181898005408;4858.910668412581;4868.002059577787;4879.902401951958;4897.461279259283;4904.950950490494;4575;4781.11549363368;4818.08456393285;4819.25301578255;4825.962418080112;3623.691986181165;3772.1701225730294;3794.7153963452784;3804.1440675847853;3857.6112599464172;3854;3855;3856.553792327877;3857.9807100964454;3872;3845.6346647068485;3848.288066707668;3851.691864650821;3852.576216616184;3863.092173339263;3706.314331848617;3788.8105594720155;3811.4663947047434;3854.9398915298375;3854.94217586735;3499.352619765326;3504.5093686883856;3509.1051781795477;3509.1051781795736;3515.9824200878834;4676.181668208084;4694;4696.060787842445;4700.55344742249;4724.149653062447;4270.807813648394;4440.888977775549;4447.933281000787;4449.2658711312915;4466.240739074366;5023.447420783711;5032.974835125801;5042.243663450475;5046.167382381903;5066.164082926312;3839.462475253467;3842.9231415371814;3844.192719528902;3845.3078445879732;3865.768053916774;5061.493850614909;5125.79496820123;5179.031967852192;5302.250257415044;5308.495692909168;3925.877828280294;3939.487866577384;3948.2893079245437;3951.1900060487533;3977.1449138434796;4014.7189696721534;4033.4554835097474;4035.576264492186;4051.169510250392;4060.898477538085;4358.56414358568;4451.154280686659;4459.955400445954;4486.371907932892;4515.277555591156;5098.8017815813255;5105.285260063594;5118.155504341742;5125.538701516882;5132.743362831843;1334.9265790381428;1353.2151352215692;1360.5646043424283;1363.6181869076675;1363.9727205455836;943.3962264150949;968.7190714692802;974.858645496399;980.3382716666222;992.8957459466652;4228.809703563347;4233.70364074518;4248.830046798155;4249.128928569636;4256.2551553478015;5042.831098124452;5045.84862454127;5046.369203849519;5064.569511591482;5082.186850103965;4115.670746340285;4230.725002874803;4248.447701798808;4254.446921900133;4265.55211702773;2629.5529759940855;2667.733226677317;2680.731926807304;2690.56950887857;2694.218676583808;4585.555550001739;4587.816487340536;4594.1730488512385;4594.5864872161665;4634.142683603544;4910.140725373046;5160.92258616121;5182.740862956913;5225.216217567319;5254.579633629301;4533.478649955297;4549.181147393435;4549.522300158502;4564.748938808398;4575.405197324393;4992.675476094042;4993.750312484434;5042.218456139304;5064.974675126601;5081.288619593334;4766.904661906812;4976.975115124401;4982.800687972441;5002.749862506787;5010.521896040749;4495.392672250022;4557.835028361635;4605.93091103627;4630.351750754964;4715.6699031068865;3940.8817735467983;3944.230874979466;3973.185496973171;3974.880753577397;3985.242803867256;5207.229541955753;5220.190870415092;5226.477352264743;5237.031149237403;5237.921431178459;4864.6594738369395;4985.775640096132;5052.520010598987;5055.7219352935945;5090.389153301628;5015.548600625962;5038.319826823332;5038.521340472649;5040.042391945519;5040.243963405372;5001.699898006132;5002.874928126826;5010.5240002199735;5012.87467813293;5013.849584512471;4807.889254687192;5027.622928280321;5048.873778155576;5051.520105589963;5060.418051924076;4940.591931299562;4991.550760431433;5000.099982003274;5004.84985450437;5005.673496523352 07:48:51 INFO - PROCESS | 12858 | |5;yui.html;625.5527297981942;639.5235549515612;684.2746688510179;700.1108592088045;700.8212905709045;11355.772884542315;12189.08581856362;12216.022718182558;12233.266004039742;12237.938810305946;12057.819132712995;12102.69743256419;12153.331566763825;12154.513819447233;12158.148929574932;647.6340867409898;666.7732970789931;797.5015615240475;799.8560259153364;803.8794180872886;814.0109766633539;815.1237419773737;816.1593558634615;816.3999460396603;816.4244207833493;863.1541089732067;869.1525762381659;869.6477926439802;870.0125357719003;870.2341939093589;690.8100272425073;714.6783947223718;717.9210286868492;719.1478098453349;865.9783505412383;611.2817439508559;631.26142413376;632.8670979094396;635.8187916443837;637.5377851057992;11386.146039047104;11537.826932596017;11648.650540483713;11654.242474239147;11775.823362649482;13057;13060.318761338753;13117.803232951514;13201.867981320256;13339.933300333436;9192.494412807293;9323.766905827408;9464.52677366129;11572.900574445499;11961.162718609701;4143.606357396043;4151.83392664293;4175.290200665863;4179.958200417987;4214.852480163179;61054.69472652608;62712.05931911025;64135.67932160356;64320.35679643191;64557.677211614115;10192.113649759722;10196.796064078677;10289.073983341535;10517.842232366367;10637.361758294526;19913.701294480594;21496.677549836764;21532.569348613255;21568.24511142134;21584.892075539523;6340.968295158495;6354.9682251589375;6366.904496432558;6388.4569811566535;6684.732610695615;3034.544818277276;3102.1314032071054;3143.104215298629;3153.526970954375;3238.481842905124;2848.544232922764;2914.256864499539;2936.148516930109;2945.528715405525;2952.070097919149;492.3574734970826;493.8715933857223;494.8144445832813;505.0303417438453;506.7364970215467;485.40053034502364;490.73009844585334;510.6093838213769;515.8968206358743;519.9220116982483;7963.960180199178;8202;8253.546054967035;8570.21468022895;8868.733937981871;531.1528112660301;547.9506844384025;548.0135755639832;549.4917201588514;553.6788662575697;3964.742291751027;4145.419641250227;4189.308764053897;4203.390508376268;4320.265554855682;64977.675111624136;65424.644988526314;65811;66412.33587664158;67724.32275677279;53438.7328063365;57760.422395776346;58166;58405.41594584085;59274.77614850465;51530.48469515407;52186.739066305185;52565;52851.73574132105;53188.46811531913;7734.381249500139;7828;8165.591720413837;8321.542315172723;8381;35174.648253518164;35839.46240806338;36183.27633447263;37207.81396093002;37287.25425491421;43321.78339108284;44754.77622611996;47623.28565071596;47796.522034779206;48517.266891959785;11126.88873111291;11754.647360579196;11830.349330786888;12021.459034343301;12643.114981951176;12156.574519891761;12377.443015064164;12571.18287311322;12634.368281586068;13483.258420786558;11712.648620541397;11872.46573904159;12135.817962730389;12300.753984920431;12625.368731563569;11658.300501969909;11675.474603643026;11975.580854670045;12042.157049006486;12224.266544007389;10784.568617255221;10902;11059.336439813636;11254.549818007188;11485.138614603771;9051;9256.49089300068;9342.766430839283;9372.812543749224;9555.61777528891;10160;10236.931998729162;10265.692029239135;10363.585456581652;10383.428911409643 07:48:51 INFO - PROCESS | 12858 | __end_tp_report 07:48:51 INFO - PROCESS | 12858 | __start_cc_report 07:48:51 INFO - PROCESS | 12858 | _x_x_mozilla_cycle_collect,992 07:48:51 INFO - PROCESS | 12858 | __end_cc_report 07:48:51 INFO - PROCESS | 12858 | __startTimestamp1484668131754__endTimestamp 07:48:51 INFO - PROCESS | 12858 | 07:48:51 INFO - PROCESS | 12858 | ------- Summary: start ------- 07:48:51 INFO - PROCESS | 12858 | Number of tests: 6 07:48:51 INFO - PROCESS | 12858 | 07:48:51 INFO - PROCESS | 12858 | [#0] dojo.html Cycles:165 Average:4695.21 Median:4785.59 stddev:508.63 (10.6%) stddev-sans-first:481.20 07:48:51 INFO - PROCESS | 12858 | Values: 2537.3 2541.6 2569.0 2570.7 2571.6 4676.9 4735.6 4752.9 4786.3 4798.1 4748.3 4750.1 4751.3 4774.8 4792.3 4308.8 4351.6 4353.1 4369.6 4398.1 4449.1 4456.2 4460.4 4479.6 4484.3 4316.0 4342.7 4373.3 4375.3 4397.2 4357.7 4371.4 4373.3 4426.9 4437.5 4351.7 4360.2 4368.0 4387.0 4393.3 4642.4 4681.4 4729.1 4784.4 4785.6 5027.4 5046.8 5060.6 5098.1 5128.0 5106.1 5108.8 5125.2 5130.3 5177.3 4666.7 4778.8 4786.5 4789.8 4825.2 5197.7 5198.8 5211.3 5214.7 5218.8 4991.8 5084.6 5098.9 5106.2 5110.7 4992.0 5002.6 5007.1 5074.9 5207.0 5001.9 5002.5 5044.5 5045.4 5049.0 4985.5 5001.9 5011.2 5053.9 5055.7 4348.8 4351.8 4360.8 4361.0 4405.5 3720.5 3726.0 3736.0 3750.7 3777.9 4366.3 4377.6 4395.5 4414.4 4414.7 5119.8 5125.3 5126.6 5133.4 5135.7 4252.8 4281.1 4307.6 4369.9 4380.6 4598.4 4655.4 4664.0 4684.3 4690.3 4654.8 4656.1 4658.1 4658.4 4697.3 5139.8 5140.0 5145.7 5146.6 5191.4 4519.1 4564.5 4609.7 4624.2 4650.2 5055.5 5056.8 5058.2 5058.7 5096.3 5106.2 5142.8 5158.7 5161.2 5193.7 4818.2 4849.8 4952.8 4968.6 5004.3 4982.5 5019.0 5025.3 5045.6 5061.0 4820.6 4838.9 4841.1 4942.0 4998.7 4968.2 4985.4 4988.0 4988.6 5001.1 4693.9 4764.3 4772.1 4777.7 4879.1 07:48:51 INFO - PROCESS | 12858 | 07:48:51 INFO - PROCESS | 12858 | [#1] ext.html Cycles:180 Average:47184.34 Median:343558.50 stddev:84813.87 (24.7%) stddev-sans-first:84979.43 07:48:51 INFO - PROCESS | 12858 | Values: 520.4 535.4 543.9 561.2 581.1 29860.4 45281.5 46801.0 46849.5 47052.8 41417.8 41715.4 41754.0 41757.6 41760.4 7716.2 7874.1 7891.3 7893.5 7899.4 7584.2 7802.0 9922.6 10126.6 10153.1 10180.7 10217.6 10254.9 10257.3 10263.2 9959.3 10008.8 10010.8 10024.8 10029.1 10063.5 10134.1 10140.8 10141.9 10150.3 38599.8 38910.8 38915.0 38957.8 38959.4 3578.3 3687.4 3690.4 3723.2 3728.5 26380.9 26505.2 27623.1 29919.0 31433.5 3307.1 3391.2 3423.2 3543.6 3546.9 254124.0 254358.0 254987.0 255314.0 255814.0 48185.0 48801.0 48807.3 48945.0 49014.0 49952.5 50037.0 50113.5 50116.7 50269.0 11329.9 11410.7 11419.4 11421.4 11423.6 7915.3 8102.2 9249.1 9267.6 9274.1 15531.8 16048.6 16218.8 16566.4 16594.4 6662.5 6841.9 6888.9 6901.3 6949.3 818.3 834.8 835.7 844.6 859.8 27249.3 27818.0 28358.4 28839.1 28935.9 991.8 994.4 998.7 1006.8 1117.9 15184.8 15215.9 15292.9 15400.9 15532.6 357091.0 359714.0 360181.0 360693.0 360772.0 52195.2 52812.2 52845.7 52905.5 53000.2 1194.6 1199.8 1240.5 1246.2 1254.3 26306.8 27352.2 27481.0 28111.6 28145.3 37687.6 42576.4 43549.6 43667.6 48849.8 340119.0 343406.0 343711.0 344015.0 344871.0 28931.6 29810.0 34938.0 35153.5 35429.1 40670.4 40739.0 41012.6 41129.8 42380.0 31744.4 32068.5 32142.4 32199.4 32211.8 31615.8 32014.2 32071.2 32122.2 33104.2 30951.4 31372.7 31680.2 31722.8 32151.0 27627.6 28351.0 29273.0 29354.0 29388.1 22251.3 22571.2 23032.8 23095.9 23171.8 07:48:51 INFO - PROCESS | 12858 | 07:48:51 INFO - PROCESS | 12858 | [#2] jquery.html Cycles:180 Average:24874.83 Median:27935.88 stddev:65079.89 (233.0%) stddev-sans-first:65236.40 07:48:51 INFO - PROCESS | 12858 | Values: 347.3 375.8 376.6 381.2 396.7 13462.4 13524.3 18044.3 18051.9 18086.6 17173.6 17230.4 17495.7 17787.9 17826.5 3835.5 5018.1 5203.8 5206.7 5213.5 4023.7 5972.5 6206.6 6242.3 6375.9 6071.6 6213.6 6297.2 6310.4 6312.6 6043.4 6068.6 6070.0 6072.6 6077.6 5223.3 5334.7 5370.3 5371.3 5378.8 18167.7 18253.0 19318.7 21214.3 21441.8 2222.4 2245.6 2259.8 2261.1 2338.6 12876.7 13608.5 13632.9 14181.1 14224.1 1500.6 1558.9 1600.4 1842.6 1914.4 54591.7 63865.0 66367.3 75039.2 75065.2 10368.0 10418.9 10528.5 10735.3 10808.3 14718.5 14737.1 14755.5 14763.3 14775.9 6571.6 6752.7 6797.0 6903.2 6934.3 6156.5 6201.3 6360.7 6366.6 6368.2 4489.1 4494.6 4518.6 4540.2 4649.7 1799.8 1877.9 1916.5 1929.4 1935.7 759.7 781.4 784.8 791.9 797.2 16623.4 16682.5 16767.0 17298.8 17450.6 806.0 807.2 811.4 811.6 819.0 9577.7 9897.3 9957.4 9997.6 10142.6 318733.0 320404.0 320811.0 476547.0 477295.0 93076.5 93492.0 97689.5 97921.0 102194.0 833.5 835.0 865.9 867.4 868.3 15477.3 15507.4 15846.0 16449.3 16765.2 36254.1 39740.2 40348.3 41980.8 42202.4 50668.0 53984.5 54471.7 55176.7 55383.2 7079.9 7247.0 7305.5 7409.0 7687.2 9908.0 9910.4 10626.5 11284.5 11335.9 9289.0 9384.7 9409.3 9439.9 9545.1 9551.9 10222.9 10392.7 10428.8 10581.0 9635.5 9819.7 9897.6 10203.7 10250.6 7280.7 7437.4 7600.1 7605.7 7686.0 9002.4 9901.8 9947.3 9982.3 10285.6 07:48:51 INFO - PROCESS | 12858 | 07:48:51 INFO - PROCESS | 12858 | [#3] mootools.html Cycles:180 Average:4465.36 Median:4655.99 stddev:2331.21 (50.1%) stddev-sans-first:2325.63 07:48:51 INFO - PROCESS | 12858 | Values: 1302.8 1320.6 1332.9 1346.3 1346.8 6539.4 6872.9 6908.6 6920.2 6926.8 5926.0 6147.5 6429.5 6639.7 6641.3 2136.9 2168.4 2175.2 2176.6 2177.1 2093.9 2134.9 2140.4 2141.4 2146.7 1869.6 1935.2 2095.5 2139.0 2170.1 2163.6 2169.6 2169.7 2175.4 2175.8 2069.9 2085.2 2093.0 2112.9 2118.8 6626.3 6682.4 6689.9 6696.8 6699.4 4001.6 4107.4 4108.0 4109.3 4111.1 2678.7 2873.7 2876.3 2925.2 2939.2 1045.2 1090.1 1100.5 1108.1 1130.8 8836.1 8899.0 8905.1 8913.9 8932.2 3784.5 4000.1 4048.7 4064.3 4076.2 7785.3 7795.0 7798.6 7802.6 7802.9 4286.3 4299.0 4301.8 4306.8 4311.8 3399.3 3515.4 3762.6 3808.9 3882.3 3290.4 3313.3 3444.8 3453.8 3457.4 1181.2 1216.3 1220.2 1223.6 1225.5 720.9 735.2 752.5 760.6 767.4 4320.2 4634.6 4777.5 4783.9 4914.4 809.8 825.8 828.0 831.0 854.9 3023.9 3056.1 3092.5 3111.0 3173.7 7863.3 8087.4 8102.4 8174.4 8210.8 8027.2 8135.2 8145.9 8152.1 8157.6 6371.3 6419.8 6431.3 6480.5 6492.9 4441.2 4486.8 4553.4 4562.0 4677.3 7119.9 7210.5 7322.4 7346.6 7494.8 7465.5 7504.8 7552.9 7570.0 7590.1 5304.0 5519.7 5628.4 5791.0 5791.4 6073.7 6224.9 6276.3 6415.3 6432.1 5457.3 5519.4 5534.1 5594.6 5645.6 5732.7 5775.9 5785.1 5796.8 5889.9 5102.7 5106.3 5117.8 5147.7 5174.0 3836.8 3885.5 3895.3 3930.4 3936.6 3939.2 3940.6 3962.8 4043.6 4052.3 07:48:51 INFO - PROCESS | 12858 | 07:48:51 INFO - PROCESS | 12858 | [#4] prototype.html Cycles:180 Average:4199.76 Median:4594.38 stddev:1162.08 (25.3%) stddev-sans-first:1128.85 07:48:51 INFO - PROCESS | 12858 | Values: 350.2 354.5 358.9 364.3 370.2 4858.9 4868.0 4879.9 4897.5 4905.0 4575.0 4781.1 4818.1 4819.3 4826.0 3623.7 3772.2 3794.7 3804.1 3857.6 3854.0 3855.0 3856.6 3858.0 3872.0 3845.6 3848.3 3851.7 3852.6 3863.1 3706.3 3788.8 3811.5 3854.9 3854.9 3499.4 3504.5 3509.1 3509.1 3516.0 4676.2 4694.0 4696.1 4700.6 4724.1 4270.8 4440.9 4447.9 4449.3 4466.2 5023.4 5033.0 5042.2 5046.2 5066.2 3839.5 3842.9 3844.2 3845.3 3865.8 5061.5 5125.8 5179.0 5302.3 5308.5 3925.9 3939.5 3948.3 3951.2 3977.1 4014.7 4033.5 4035.6 4051.2 4060.9 4358.6 4451.2 4460.0 4486.4 4515.3 5098.8 5105.3 5118.2 5125.5 5132.7 1334.9 1353.2 1360.6 1363.6 1364.0 943.4 968.7 974.9 980.3 992.9 4228.8 4233.7 4248.8 4249.1 4256.3 5042.8 5045.8 5046.4 5064.6 5082.2 4115.7 4230.7 4248.4 4254.4 4265.6 2629.6 2667.7 2680.7 2690.6 2694.2 4585.6 4587.8 4594.2 4594.6 4634.1 4910.1 5160.9 5182.7 5225.2 5254.6 4533.5 4549.2 4549.5 4564.7 4575.4 4992.7 4993.8 5042.2 5065.0 5081.3 4766.9 4977.0 4982.8 5002.7 5010.5 4495.4 4557.8 4605.9 4630.4 4715.7 3940.9 3944.2 3973.2 3974.9 3985.2 5207.2 5220.2 5226.5 5237.0 5237.9 4864.7 4985.8 5052.5 5055.7 5090.4 5015.5 5038.3 5038.5 5040.0 5040.2 5001.7 5002.9 5010.5 5012.9 5013.8 4807.9 5027.6 5048.9 5051.5 5060.4 4940.6 4991.6 5000.1 5004.8 5005.7 07:48:51 INFO - PROCESS | 12858 | 07:48:51 INFO - PROCESS | 12858 | [#5] yui.html Cycles:180 Average:14872.52 Median:24140.96 stddev:18578.31 (77.0%) stddev-sans-first:18599.63 07:48:51 INFO - PROCESS | 12858 | Values: 625.6 639.5 684.3 700.1 700.8 11355.8 12189.1 12216.0 12233.3 12237.9 12057.8 12102.7 12153.3 12154.5 12158.1 647.6 666.8 797.5 799.9 803.9 814.0 815.1 816.2 816.4 816.4 863.2 869.2 869.6 870.0 870.2 690.8 714.7 717.9 719.1 866.0 611.3 631.3 632.9 635.8 637.5 11386.1 11537.8 11648.7 11654.2 11775.8 13057.0 13060.3 13117.8 13201.9 13339.9 9192.5 9323.8 9464.5 11572.9 11961.2 4143.6 4151.8 4175.3 4180.0 4214.9 61054.7 62712.1 64135.7 64320.4 64557.7 10192.1 10196.8 10289.1 10517.8 10637.4 19913.7 21496.7 21532.6 21568.2 21584.9 6341.0 6355.0 6366.9 6388.5 6684.7 3034.5 3102.1 3143.1 3153.5 3238.5 2848.5 2914.3 2936.1 2945.5 2952.1 492.4 493.9 494.8 505.0 506.7 485.4 490.7 510.6 515.9 519.9 7964.0 8202.0 8253.5 8570.2 8868.7 531.2 548.0 548.0 549.5 553.7 3964.7 4145.4 4189.3 4203.4 4320.3 64977.7 65424.6 65811.0 66412.3 67724.3 53438.7 57760.4 58166.0 58405.4 59274.8 51530.5 52186.7 52565.0 52851.7 53188.5 7734.4 7828.0 8165.6 8321.5 8381.0 35174.6 35839.5 36183.3 37207.8 37287.3 43321.8 44754.8 47623.3 47796.5 48517.3 11126.9 11754.6 11830.3 12021.5 12643.1 12156.6 12377.4 12571.2 12634.4 13483.3 11712.6 11872.5 12135.8 12300.8 12625.4 11658.3 11675.5 11975.6 12042.2 12224.3 10784.6 10902.0 11059.3 11254.5 11485.1 9051.0 9256.5 9342.8 9372.8 9555.6 10160.0 10236.9 10265.7 10363.6 10383.4 07:48:51 INFO - PROCESS | 12858 | -------- Summary: end -------- 07:48:51 INFO - PROCESS | 12858 | 07:48:52 INFO - TEST-INFO | 12858: exit 0 07:48:52 INFO - TEST-OK | dromaeo_css | took 1121408ms 07:48:52 INFO - TEST-START | kraken 07:48:52 INFO - operating with platform_type : linux_ 07:48:52 INFO - Initialising browser for kraken test... 07:48:52 INFO - TEST-INFO | started process 13190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKzNDdM/profile http://localhost:34754/getInfo.html) 07:48:56 INFO - PROCESS | 13190 | __metrics Screen width/height:1600/1200 07:48:56 INFO - PROCESS | 13190 | colorDepth:24 07:48:56 INFO - PROCESS | 13190 | Browser inner width/height: 1024/697 07:48:56 INFO - PROCESS | 13190 | __metrics 07:48:56 INFO - PROCESS | 13190 | 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" 07:48:56 INFO - PROCESS | 13190 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:48:57 INFO - PROCESS | 13190 | console.error: PushService: 07:48:57 INFO - PROCESS | 13190 | stateChangeProcessEnqueue: Error transitioning state 07:48:57 INFO - PROCESS | 13190 | UnknownError 07:48:58 INFO - TEST-INFO | 13190: exit 0 07:48:58 INFO - Browser initialized. 07:48:58 INFO - Running cycle 1/1 for kraken test... 07:48:58 INFO - TEST-INFO | started process 13273 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKzNDdM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:49:10 INFO - PROCESS | 13273 | RSS: Main: 152346624 07:49:10 INFO - PROCESS | 13273 | 07:49:13 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:34754/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34754/tests/kraken/driver.html?testName=audio-beat-detection) 07:49:14 INFO - PROCESS | 13273 | RSS: Main: 207982592 07:49:14 INFO - PROCESS | 13273 | 07:49:16 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:34754/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34754/tests/kraken/driver.html?testName=audio-dft) 07:49:17 INFO - PROCESS | 13273 | RSS: Main: 186658816 07:49:17 INFO - PROCESS | 13273 | 07:49:20 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:34754/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34754/tests/kraken/driver.html?testName=audio-fft) 07:49:21 INFO - PROCESS | 13273 | RSS: Main: 268967936 07:49:21 INFO - PROCESS | 13273 | 07:49:23 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:34754/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34754/tests/kraken/driver.html?testName=audio-oscillator) 07:49:23 INFO - PROCESS | 13273 | RSS: Main: 180174848 07:49:23 INFO - PROCESS | 13273 | 07:49:26 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:34754/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34754/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:49:26 INFO - PROCESS | 13273 | RSS: Main: 183681024 07:49:26 INFO - PROCESS | 13273 | 07:49:29 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:34754/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34754/tests/kraken/driver.html?testName=imaging-darkroom) 07:49:30 INFO - PROCESS | 13273 | RSS: Main: 223125504 07:49:30 INFO - PROCESS | 13273 | 07:49:33 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:34754/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34754/tests/kraken/driver.html?testName=imaging-desaturate) 07:49:34 INFO - PROCESS | 13273 | RSS: Main: 216551424 07:49:34 INFO - PROCESS | 13273 | 07:49:37 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:34754/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34754/tests/kraken/driver.html?testName=json-parse-financial) 07:49:37 INFO - PROCESS | 13273 | RSS: Main: 218456064 07:49:37 INFO - PROCESS | 13273 | 07:49:39 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:34754/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34754/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:49:40 INFO - PROCESS | 13273 | RSS: Main: 182169600 07:49:40 INFO - PROCESS | 13273 | 07:49:42 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:34754/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34754/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:49:42 INFO - PROCESS | 13273 | RSS: Main: 190050304 07:49:42 INFO - PROCESS | 13273 | 07:49:44 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:34754/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34754/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:49:45 INFO - PROCESS | 13273 | RSS: Main: 198012928 07:49:45 INFO - PROCESS | 13273 | 07:49:48 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:34754/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34754/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:49:49 INFO - PROCESS | 13273 | RSS: Main: 206200832 07:49:49 INFO - PROCESS | 13273 | 07:49:52 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:34754/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34754/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:49:52 INFO - PROCESS | 13273 | RSS: Main: 203038720 07:49:52 INFO - PROCESS | 13273 | 07:49:54 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:34754/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34754/tests/kraken/driver.html?testName=ai-astar) 07:49:54 INFO - PROCESS | 13273 | RSS: Main: 254545920 07:49:54 INFO - PROCESS | 13273 | 07:49:54 INFO - PROCESS | 13273 | __start_tp_report 07:49:54 INFO - PROCESS | 13273 | _x_x_mozilla_page_load 07:49:54 INFO - PROCESS | 13273 | _x_x_mozilla_page_load_details 07:49:54 INFO - PROCESS | 13273 | |i|pagename|runs| 07:49:54 INFO - PROCESS | 13273 | |0;ai-astar;107;115;114;117;117;114;116;115;115;118 07:49:54 INFO - PROCESS | 13273 | |1;audio-beat-detection;146;130;125;174;128;126;125;126;151;125 07:49:54 INFO - PROCESS | 13273 | |2;audio-dft;161;160;160;161;162;161;163;161;161;162 07:49:54 INFO - PROCESS | 13273 | |3;audio-fft;75;76;78;109;76;77;75;75;97;76 07:49:54 INFO - PROCESS | 13273 | |4;audio-oscillator;85;85;117;86;83;85;100;85;83;108 07:49:54 INFO - PROCESS | 13273 | |5;imaging-gaussian-blur;116;118;117;117;117;117;117;117;117;117 07:49:54 INFO - PROCESS | 13273 | |6;imaging-darkroom;148;150;149;149;150;149;149;149;149;149 07:49:54 INFO - PROCESS | 13273 | |7;imaging-desaturate;95;95;96;96;96;96;96;96;96;96 07:49:54 INFO - PROCESS | 13273 | |8;json-parse-financial;59;58;59;58;59;59;59;60;59;60 07:49:54 INFO - PROCESS | 13273 | |9;json-stringify-tinderbox;66;70;68;68;67;67;67;67;68;69 07:49:54 INFO - PROCESS | 13273 | |10;stanford-crypto-aes;85;86;85;87;86;85;88;85;90;84 07:49:54 INFO - PROCESS | 13273 | |11;stanford-crypto-ccm;140;132;137;136;141;134;132;142;173;139 07:49:54 INFO - PROCESS | 13273 | |12;stanford-crypto-pbkdf2;177;179;178;175;175;177;175;188;176;175 07:49:54 INFO - PROCESS | 13273 | |13;stanford-crypto-sha256-iterative;71;69;68;69;69;69;67;67;73;67 07:49:54 INFO - PROCESS | 13273 | __end_tp_report 07:49:54 INFO - PROCESS | 13273 | __start_cc_report 07:49:54 INFO - PROCESS | 13273 | _x_x_mozilla_cycle_collect,1824 07:49:54 INFO - PROCESS | 13273 | __end_cc_report 07:49:54 INFO - PROCESS | 13273 | __startTimestamp1484668194695__endTimestamp 07:49:54 INFO - PROCESS | 13273 | 07:49:54 INFO - PROCESS | 13273 | ------- Summary: start ------- 07:49:54 INFO - PROCESS | 13273 | Number of tests: 14 07:49:54 INFO - PROCESS | 13273 | 07:49:54 INFO - PROCESS | 13273 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.50 stddev:3.05 (2.6%) stddev-sans-first:1.41 07:49:54 INFO - PROCESS | 13273 | Values: 107.0 115.0 114.0 117.0 117.0 114.0 116.0 115.0 115.0 118.0 07:49:54 INFO - PROCESS | 13273 | 07:49:54 INFO - PROCESS | 13273 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:129.00 stddev:16.43 (12.7%) stddev-sans-first:16.99 07:49:54 INFO - PROCESS | 13273 | Values: 146.0 130.0 125.0 174.0 128.0 126.0 125.0 126.0 151.0 125.0 07:49:54 INFO - PROCESS | 13273 | 07:49:54 INFO - PROCESS | 13273 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 07:49:54 INFO - PROCESS | 13273 | Values: 161.0 160.0 160.0 161.0 162.0 161.0 163.0 161.0 161.0 162.0 07:49:54 INFO - PROCESS | 13273 | 07:49:54 INFO - PROCESS | 13273 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.00 stddev:11.77 (15.5%) stddev-sans-first:12.25 07:49:54 INFO - PROCESS | 13273 | Values: 75.0 76.0 78.0 109.0 76.0 77.0 75.0 75.0 97.0 76.0 07:49:54 INFO - PROCESS | 13273 | 07:49:54 INFO - PROCESS | 13273 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:85.00 stddev:12.19 (14.3%) stddev-sans-first:12.69 07:49:54 INFO - PROCESS | 13273 | Values: 85.0 85.0 117.0 86.0 83.0 85.0 100.0 85.0 83.0 108.0 07:49:54 INFO - PROCESS | 13273 | 07:49:54 INFO - PROCESS | 13273 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 07:49:54 INFO - PROCESS | 13273 | Values: 116.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 07:49:54 INFO - PROCESS | 13273 | 07:49:54 INFO - PROCESS | 13273 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 07:49:54 INFO - PROCESS | 13273 | Values: 148.0 150.0 149.0 149.0 150.0 149.0 149.0 149.0 149.0 149.0 07:49:54 INFO - PROCESS | 13273 | 07:49:54 INFO - PROCESS | 13273 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 07:49:54 INFO - PROCESS | 13273 | Values: 95.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 07:49:54 INFO - PROCESS | 13273 | 07:49:54 INFO - PROCESS | 13273 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 07:49:54 INFO - PROCESS | 13273 | Values: 59.0 58.0 59.0 58.0 59.0 59.0 59.0 60.0 59.0 60.0 07:49:54 INFO - PROCESS | 13273 | 07:49:54 INFO - PROCESS | 13273 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:1.16 (1.7%) stddev-sans-first:1.05 07:49:54 INFO - PROCESS | 13273 | Values: 66.0 70.0 68.0 68.0 67.0 67.0 67.0 67.0 68.0 69.0 07:49:54 INFO - PROCESS | 13273 | 07:49:54 INFO - PROCESS | 13273 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:1.79 (2.1%) stddev-sans-first:1.86 07:49:54 INFO - PROCESS | 13273 | Values: 85.0 86.0 85.0 87.0 86.0 85.0 88.0 85.0 90.0 84.0 07:49:54 INFO - PROCESS | 13273 | 07:49:54 INFO - PROCESS | 13273 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:139.50 stddev:11.93 (8.6%) stddev-sans-first:12.65 07:49:54 INFO - PROCESS | 13273 | Values: 140.0 132.0 137.0 136.0 141.0 134.0 132.0 142.0 173.0 139.0 07:49:54 INFO - PROCESS | 13273 | 07:49:54 INFO - PROCESS | 13273 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.50 Median:177.00 stddev:3.95 (2.2%) stddev-sans-first:4.19 07:49:54 INFO - PROCESS | 13273 | Values: 177.0 179.0 178.0 175.0 175.0 177.0 175.0 188.0 176.0 175.0 07:49:54 INFO - PROCESS | 13273 | 07:49:54 INFO - PROCESS | 13273 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.91 (2.8%) stddev-sans-first:1.87 07:49:54 INFO - PROCESS | 13273 | Values: 71.0 69.0 68.0 69.0 69.0 69.0 67.0 67.0 73.0 67.0 07:49:54 INFO - PROCESS | 13273 | -------- Summary: end -------- 07:49:54 INFO - PROCESS | 13273 | 07:49:55 INFO - TEST-INFO | 13273: exit 0 07:49:55 INFO - TEST-OK | kraken | took 63284ms 07:49:55 INFO - SUITE-END | took 1184s 07:49:56 INFO - Completed test suite (00:19:45) 07:49:56 INFO - javascript benchmark 07:49:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2537.3402915242036, 2541.5552278351283, 2568.9614655780156, 2570.7429257074295, 2571.6399704041437, 4676.859694209171, 4735.597474214687, 4752.904941901164, 4786.282057691348, 4798.136335459616, 4748.264019077049, 4750.121227572901, 4751.311059896313, 4774.80900763969, 4792.329073929653, 4308.80610372534, 4351.586599273064, 4353.129374125172, 4369.563043695637, 4398.076403955173, 4449.087936972929, 4456.175607512604, 4460.420145381096, 4479.619232365253, 4484.304932735415, 4316.028893498969, 4342.69601127918, 4373.322135069069, 4375.343698445226, 4397.208502469554, 4357.7385356878685, 4371.409859668967, 4373.322135069069, 4426.889327766799, 4437.4896886858105, 4351.6953813233085, 4360.236958532244, 4368.017196130877, 4386.978065109686, 4393.340998850166, 4642.419697537808, 4681.391419115527, 4729.101470720552, 4784.354112194878, 4785.593224575915, 5027.421846487664, 5046.84859454217, 5060.620453466005, 5098.056859481007, 5127.974360128175, 5106.055379754757, 5108.846734597968, 5125.179971204627, 5130.271286596835, 5177.275181474596, 4666.65000124992, 4778.832740854088, 4786.545278198566, 4789.808407663724, 4825.179719447702, 5197.688138711689, 5198.844034678966, 5211.348581427322, 5214.713190774544, 5218.843434696889, 4991.750412479361, 5084.618653600995, 5098.923516147261, 5106.234064890222, 5110.66780659256, 4991.975040124777, 5002.59979201663, 5007.098722229961, 5074.898502029939, 5207.010667973073, 5001.89996200074, 5002.474740152305, 5044.495550444926, 5045.369328833895, 5049.01544198885, 4985.476524964899, 5001.899962000813, 5011.198208286657, 5053.9241911371355, 5055.696658200446, 4348.782560871944, 4351.782410879507, 4360.825566977349, 4361.0, 4405.537418571068, 3720.516332876709, 3725.981370093132, 3736.0, 3750.7374483785875, 3777.9433308500393, 4366.279563871989, 4377.562243775661, 4395.516493185747, 4414.426124603781, 4414.690971631955, 5119.820806271762, 5125.33370661819, 5126.641135120506, 5133.435322114565, 5135.717535535581, 4252.787360631956, 4281.079567892918, 4307.6338511226895, 4369.890752731144, 4380.6057454829215, 4598.356230127785, 4655.371524844103, 4664.043871006435, 4684.273937539687, 4690.296455531698, 4654.790534426027, 4656.092062047868, 4658.068386322817, 4658.417697787777, 4697.295405689174, 5139.8458046258675, 5139.997700448376, 5145.742712864417, 5146.639735218499, 5191.402988656202, 4519.118771839459, 4564.520725323793, 4609.746463944515, 4624.1676498230645, 4650.232711602548, 5055.469175736494, 5056.84829455117, 5058.241263810458, 5058.671186372874, 5096.311997880239, 5106.157484015096, 5142.820001299937, 5158.716270605153, 5161.200013997836, 5193.68837869729, 4818.204996175592, 4849.781759820746, 4952.826651067196, 4968.552830245295, 5004.274380214922, 4982.4768399317545, 5019.0463811875625, 5025.271335656383, 5045.596352291735, 5060.974695126501, 4820.566149046603, 4838.927416088691, 4841.05599408112, 4941.975290123526, 4998.6750861193905, 4968.205087186033, 4985.401751789664, 4988.02733466985, 4988.625853060962, 5001.149804533311, 4693.859184224479, 4764.332993380999, 4772.0694464580465, 4777.689450185727, 4879.146149423907], "value": 4660.978517287677, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [520.3989392251949, 535.3522238091908, 543.8667526456019, 561.1582626060908, 581.107999221195, 29860.402791944147, 45281.54718452814, 46801.0, 46849.53150468494, 47052.76473617627, 41417.7929110354, 41715.37426938591, 41754.0, 41757.58242417575, 41760.37359439611, 7716.151223365426, 7874.094479134916, 7891.289783919446, 7893.526388416684, 7899.3680505559705, 7584.241575842427, 7802.0, 9922.603095876157, 10126.645567405143, 10153.136983356424, 10180.745481362988, 10217.642382516577, 10254.897451025507, 10257.281990260684, 10263.178945684365, 9959.25305602079, 10008.79982400348, 10010.849837252446, 10024.849627255597, 10029.097381235651, 10063.496825158785, 10134.13859821916, 10140.797184056277, 10141.898581014242, 10150.340227885164, 38599.8070009651, 38910.805445972874, 38915.0, 38957.80521097376, 38959.41560876589, 3578.3380074686265, 3687.3731465650635, 3690.3541880171133, 3723.1622884850963, 3728.5152930119184, 26380.86809565959, 26505.204843854714, 27623.09422644339, 29919.0, 31433.528497072562, 3307.1236122427576, 3391.1522119470133, 3423.246885685145, 3543.6102028776813, 3546.9113272168142, 254124.0, 254358.0, 254987.0, 255314.0, 255814.0, 48185.0, 48801.0, 48807.26789098166, 48945.0, 49014.0, 49952.500474994784, 50037.0, 50113.498865011614, 50116.749416252685, 50269.0, 11329.923657252548, 11410.714732131763, 11419.37193454368, 11421.42892855354, 11423.600173993871, 7915.287624113742, 8102.189781021851, 9249.075092490697, 9267.582958766872, 9274.072592740808, 15531.767023494656, 16048.598785030468, 16218.75671864923, 16566.420175293806, 16594.419195328104, 6662.533622646368, 6841.931580684229, 6888.931110688829, 6901.309869013058, 6949.270326615733, 818.3494122172887, 834.8163404051099, 835.7492752174323, 844.5650489997656, 859.7678626770737, 27249.31876703098, 27818.02636907739, 28358.43283134367, 28839.134825955254, 28935.85532072326, 991.7966816802539, 994.4033579852031, 998.7203582996773, 1006.8036732837173, 1117.8882111788755, 15184.772228416583, 15215.923920380328, 15292.923535382251, 15400.922995384952, 15532.611684707746, 357091.0, 359714.0, 360181.0, 360693.0, 360772.0, 52195.17072439088, 52812.20781688278, 52845.7357713209, 52905.47094529006, 53000.20499692508, 1194.62173599944, 1199.8200269959402, 1240.49759847262, 1246.1526162209784, 1254.328934020313, 26306.816193270966, 27352.17943461699, 27481.015252788635, 28111.57832632553, 28145.296367590156, 37687.62312376841, 42576.361354580324, 43549.56450435455, 43667.56332436635, 48849.75575122102, 340119.0, 343406.0, 343711.0, 344015.0, 344871.0, 28931.56602651004, 29810.0, 34938.0, 35153.47269790904, 35429.05140217313, 40670.38994415145, 40739.0, 41012.58987410207, 41129.79435102805, 42380.0, 31744.36511269808, 32068.51897221497, 32142.357152856344, 32199.356012879143, 32211.838940805144, 31615.84192079117, 32014.199645009063, 32071.198220044687, 32122.19694507656, 33104.1723956903, 30951.380972380877, 31372.686273136977, 31680.207994800316, 31722.841385792923, 32151.0, 27627.585586216625, 28351.0, 29273.0, 29354.0, 29388.11835644934, 22251.332460026224, 22571.210007649654, 23032.769672303733, 23095.88452057729, 23171.768282317636], "value": 17624.78299419121, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.32445393709247, 375.81585023338556, 376.55566431610725, 381.2394273424518, 396.7361704466528, 13462.394192261347, 13524.323783810807, 18044.278228870844, 18051.909740451312, 18086.638267234648, 17173.570660733487, 17230.396936107238, 17495.650086998252, 17787.911060444712, 17826.46520604384, 3835.520559930009, 5018.146915024446, 5203.765830537616, 5206.739663016853, 5213.478652134794, 4023.6982226333, 5972.492338151263, 6206.627602343851, 6242.282137554194, 6375.872482550346, 6071.63570185788, 6213.56505044647, 6297.2128483939505, 6310.4320611144985, 6312.621242725429, 6043.3956604339655, 6068.57519973602, 6069.969650151743, 6072.574919755619, 6077.574569780118, 5223.268742376071, 5334.653247538898, 5370.275012873251, 5371.301730774974, 5378.784848606051, 18167.728259021875, 18253.0, 19318.71021934672, 21214.257500987547, 21441.785582144134, 2222.355516900097, 2245.6406974884103, 2259.7514273430074, 2261.0729600863565, 2338.6024375856146, 12876.742465150644, 13608.455661773616, 13632.93183534076, 14181.078229915023, 14224.146551206857, 1500.6023403798001, 1558.8674962628077, 1600.43184669443, 1842.6314737052644, 1914.3586898388917, 54591.72704136494, 63865.0, 66367.33632663659, 75039.24960750378, 75065.24934750637, 10368.0, 10418.895811041944, 10528.473576321154, 10735.316170957261, 10808.297460665031, 14718.484853030093, 14737.11577305365, 14755.483558075415, 14763.33564989578, 14775.92612036933, 6571.605703657796, 6752.696128674222, 6796.966015169992, 6903.171619405603, 6934.306569343126, 6156.538259630545, 6201.286852012076, 6360.745570177141, 6366.618002919747, 6368.235811702625, 4489.147062058199, 4494.584205975108, 4518.570735780096, 4540.205464043779, 4649.721016739007, 1799.839103778056, 1877.9248929932228, 1916.5112896211376, 1929.4211736479, 1935.6902895536646, 759.6695437484601, 781.3631890009624, 784.8234147316922, 791.8930944322443, 797.2415442568662, 16623.418180363627, 16682.499525014027, 16767.0, 17298.82701172972, 17450.563735906704, 806.0247101007847, 807.2049031703767, 811.4279432999721, 811.6023148657116, 819.0, 9577.664781732745, 9897.25770567196, 9957.352772069793, 9997.600095996224, 10142.645007424704, 318733.0, 320404.0, 320811.0, 476547.0, 477295.0, 93076.53461732648, 93492.0, 97689.51155244178, 97921.0, 102194.0, 833.4790755777639, 834.9582520874053, 865.9437136586101, 867.3711559119714, 868.2836659755727, 15477.303521341342, 15507.379704811681, 15846.0, 16449.25978330954, 16765.245563949895, 36254.093647657966, 39740.205195896495, 40348.31931933913, 41980.79009604932, 42202.36696449494, 50668.0, 53984.460155397945, 54471.72764136154, 55176.72411637916, 55383.16925246044, 7079.8938015930835, 7247.04283887474, 7305.452091093083, 7408.962955185405, 7687.192844751221, 9907.950460247652, 9910.35582687123, 10626.52180651888, 11284.548618055185, 11335.886641133484, 9288.953555232181, 9384.67153649619, 9409.341346105706, 9439.905600944177, 9545.061978004402, 9551.856722149312, 10222.948885255526, 10392.740181495523, 10428.843567346345, 10581.0, 9635.470049147365, 9819.705408837746, 9897.604095836086, 10203.693889183336, 10250.641227557, 7280.708771649075, 7437.367823735043, 7600.087989441303, 7605.6577454015805, 7685.961570192113, 9002.369834111549, 9901.801963960537, 9947.303688741718, 9982.301238913496, 10285.640002599874], "value": 8357.031944723729, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.8406115170712, 1320.584016034949, 1332.8800407963283, 1346.3133801761098, 1346.7777816660246, 6539.378759017897, 6872.9312706872915, 6908.585484870899, 6920.204176519702, 6926.757563485279, 5926.0, 6147.538934579902, 6429.517786166033, 6639.73441062357, 6641.335866413357, 2136.861104028241, 2168.4145280774183, 2175.184305885293, 2176.6082105221053, 2177.096504950444, 2093.905774240155, 2134.8932553372347, 2140.411386868608, 2141.4004078857865, 2146.742390913085, 1869.6447674941785, 1935.158206180309, 2095.538981424092, 2139.0267428320076, 2170.0560256288486, 2163.5889181055627, 2169.5660867826496, 2169.6962425260476, 2175.369142948551, 2175.7715439878743, 2069.906854191565, 2085.1763553396477, 2093.037202886674, 2112.8837913914726, 2118.756343020557, 6626.271110177877, 6682.365175308338, 6689.93310066898, 6696.799096027127, 6699.39705426514, 4001.6198461146146, 4107.363358679379, 4108.0, 4109.2808758467445, 4111.075008123148, 2678.6785585729644, 2873.6695280042854, 2876.2665520292403, 2925.151706005256, 2939.162338733472, 1045.2265323660513, 1090.1006669497617, 1100.5267734874, 1108.1356541897333, 1130.7964566378048, 8836.116388361177, 8899.0, 8905.109489051109, 8913.866292005625, 8932.151445612657, 3784.4890939723336, 4000.099977505038, 4048.6963477739287, 4064.349704047338, 4076.2458945095254, 7785.338246249019, 7794.961025194951, 7798.649060792278, 7802.609869506502, 7802.921970780333, 4286.271333873249, 4299.0, 4301.827926882952, 4306.82772689089, 4311.762853043113, 3399.337129259771, 3515.4023815950836, 3762.62373762627, 3808.9047773805323, 3882.3400021996326, 3290.44062509374, 3313.2710803623163, 3444.844981975817, 3453.7582369234415, 3457.360388328167, 1181.161375423459, 1216.3431746856775, 1220.2434490615874, 1223.5839814462947, 1225.503671013241, 720.8738470767595, 735.1839458201392, 752.5221484357472, 760.642498025938, 767.3745897093851, 4320.243957307459, 4634.629229661619, 4777.498362671939, 4783.928241076386, 4914.410270767459, 809.7773112394021, 825.7564018614523, 828.0187977246861, 831.0484495252902, 854.9273311768445, 3023.89416370426, 3056.0831750474767, 3092.489739193053, 3110.9533356999664, 3173.6667649896426, 7863.292303692695, 8087.353011759045, 8102.39232057598, 8174.427790054639, 8210.753677389688, 8027.1972802719265, 8135.186481351936, 8145.877811832827, 8152.144024877421, 8157.592120393957, 6371.267304260069, 6419.839504012437, 6431.29255781873, 6480.481561474976, 6492.902606460907, 4441.20058389493, 4486.798094085709, 4553.408056952708, 4561.954380456153, 4677.3451716759, 7119.935218786494, 7210.459215558959, 7322.414206863332, 7346.632668366454, 7494.775156745306, 7465.477416580788, 7504.812379690333, 7552.924470755442, 7569.962150189434, 7590.127135379502, 5303.973480132575, 5519.724013799214, 5628.4090170533145, 5790.971045144747, 5791.362950075404, 6073.726682299219, 6224.9377506224355, 6276.340984196776, 6415.294317624965, 6432.067350234096, 5457.317835270591, 5519.3652729936575, 5534.142207957773, 5594.608377413542, 5645.576581756467, 5732.684702341411, 5775.884482310415, 5785.132230165509, 5796.797112101056, 5889.911651325319, 5102.668326558762, 5106.310648062464, 5117.795288188431, 5147.6654017488745, 5174.042802081627, 3836.7889766063136, 3885.4948856648457, 3895.2599006188734, 3930.4104384342577, 3936.645701886844, 3939.1727737175515, 3940.5665376807956, 3962.782046987443, 4043.595640435933, 4052.311107111739], "value": 3714.57969902167, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.2277478160655, 354.46475821509523, 358.8528703231674, 364.25509832392754, 370.181898005408, 4858.910668412581, 4868.002059577787, 4879.902401951958, 4897.461279259283, 4904.950950490494, 4575.0, 4781.11549363368, 4818.08456393285, 4819.25301578255, 4825.962418080112, 3623.691986181165, 3772.1701225730294, 3794.7153963452784, 3804.1440675847853, 3857.6112599464172, 3854.0, 3855.0, 3856.553792327877, 3857.9807100964454, 3872.0, 3845.6346647068485, 3848.288066707668, 3851.691864650821, 3852.576216616184, 3863.092173339263, 3706.314331848617, 3788.8105594720155, 3811.4663947047434, 3854.9398915298375, 3854.94217586735, 3499.352619765326, 3504.5093686883856, 3509.1051781795477, 3509.1051781795736, 3515.9824200878834, 4676.181668208084, 4694.0, 4696.060787842445, 4700.55344742249, 4724.149653062447, 4270.807813648394, 4440.888977775549, 4447.933281000787, 4449.2658711312915, 4466.240739074366, 5023.447420783711, 5032.974835125801, 5042.243663450475, 5046.167382381903, 5066.164082926312, 3839.462475253467, 3842.9231415371814, 3844.192719528902, 3845.3078445879732, 3865.768053916774, 5061.493850614909, 5125.79496820123, 5179.031967852192, 5302.250257415044, 5308.495692909168, 3925.877828280294, 3939.487866577384, 3948.2893079245437, 3951.1900060487533, 3977.1449138434796, 4014.7189696721534, 4033.4554835097474, 4035.576264492186, 4051.169510250392, 4060.898477538085, 4358.56414358568, 4451.154280686659, 4459.955400445954, 4486.371907932892, 4515.277555591156, 5098.8017815813255, 5105.285260063594, 5118.155504341742, 5125.538701516882, 5132.743362831843, 1334.9265790381428, 1353.2151352215692, 1360.5646043424283, 1363.6181869076675, 1363.9727205455836, 943.3962264150949, 968.7190714692802, 974.858645496399, 980.3382716666222, 992.8957459466652, 4228.809703563347, 4233.70364074518, 4248.830046798155, 4249.128928569636, 4256.2551553478015, 5042.831098124452, 5045.84862454127, 5046.369203849519, 5064.569511591482, 5082.186850103965, 4115.670746340285, 4230.725002874803, 4248.447701798808, 4254.446921900133, 4265.55211702773, 2629.5529759940855, 2667.733226677317, 2680.731926807304, 2690.56950887857, 2694.218676583808, 4585.555550001739, 4587.816487340536, 4594.1730488512385, 4594.5864872161665, 4634.142683603544, 4910.140725373046, 5160.92258616121, 5182.740862956913, 5225.216217567319, 5254.579633629301, 4533.478649955297, 4549.181147393435, 4549.522300158502, 4564.748938808398, 4575.405197324393, 4992.675476094042, 4993.750312484434, 5042.218456139304, 5064.974675126601, 5081.288619593334, 4766.904661906812, 4976.975115124401, 4982.800687972441, 5002.749862506787, 5010.521896040749, 4495.392672250022, 4557.835028361635, 4605.93091103627, 4630.351750754964, 4715.6699031068865, 3940.8817735467983, 3944.230874979466, 3973.185496973171, 3974.880753577397, 3985.242803867256, 5207.229541955753, 5220.190870415092, 5226.477352264743, 5237.031149237403, 5237.921431178459, 4864.6594738369395, 4985.775640096132, 5052.520010598987, 5055.7219352935945, 5090.389153301628, 5015.548600625962, 5038.319826823332, 5038.521340472649, 5040.042391945519, 5040.243963405372, 5001.699898006132, 5002.874928126826, 5010.5240002199735, 5012.87467813293, 5013.849584512471, 4807.889254687192, 5027.622928280321, 5048.873778155576, 5051.520105589963, 5060.418051924076, 4940.591931299562, 4991.550760431433, 5000.099982003274, 5004.84985450437, 5005.673496523352], "value": 3852.899563911114, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.5527297981942, 639.5235549515612, 684.2746688510179, 700.1108592088045, 700.8212905709045, 11355.772884542315, 12189.08581856362, 12216.022718182558, 12233.266004039742, 12237.938810305946, 12057.819132712995, 12102.69743256419, 12153.331566763825, 12154.513819447233, 12158.148929574932, 647.6340867409898, 666.7732970789931, 797.5015615240475, 799.8560259153364, 803.8794180872886, 814.0109766633539, 815.1237419773737, 816.1593558634615, 816.3999460396603, 816.4244207833493, 863.1541089732067, 869.1525762381659, 869.6477926439802, 870.0125357719003, 870.2341939093589, 690.8100272425073, 714.6783947223718, 717.9210286868492, 719.1478098453349, 865.9783505412383, 611.2817439508559, 631.26142413376, 632.8670979094396, 635.8187916443837, 637.5377851057992, 11386.146039047104, 11537.826932596017, 11648.650540483713, 11654.242474239147, 11775.823362649482, 13057.0, 13060.318761338753, 13117.803232951514, 13201.867981320256, 13339.933300333436, 9192.494412807293, 9323.766905827408, 9464.52677366129, 11572.900574445499, 11961.162718609701, 4143.606357396043, 4151.83392664293, 4175.290200665863, 4179.958200417987, 4214.852480163179, 61054.69472652608, 62712.05931911025, 64135.67932160356, 64320.35679643191, 64557.677211614115, 10192.113649759722, 10196.796064078677, 10289.073983341535, 10517.842232366367, 10637.361758294526, 19913.701294480594, 21496.677549836764, 21532.569348613255, 21568.24511142134, 21584.892075539523, 6340.968295158495, 6354.9682251589375, 6366.904496432558, 6388.4569811566535, 6684.732610695615, 3034.544818277276, 3102.1314032071054, 3143.104215298629, 3153.526970954375, 3238.481842905124, 2848.544232922764, 2914.256864499539, 2936.148516930109, 2945.528715405525, 2952.070097919149, 492.3574734970826, 493.8715933857223, 494.8144445832813, 505.0303417438453, 506.7364970215467, 485.40053034502364, 490.73009844585334, 510.6093838213769, 515.8968206358743, 519.9220116982483, 7963.960180199178, 8202.0, 8253.546054967035, 8570.21468022895, 8868.733937981871, 531.1528112660301, 547.9506844384025, 548.0135755639832, 549.4917201588514, 553.6788662575697, 3964.742291751027, 4145.419641250227, 4189.308764053897, 4203.390508376268, 4320.265554855682, 64977.675111624136, 65424.644988526314, 65811.0, 66412.33587664158, 67724.32275677279, 53438.7328063365, 57760.422395776346, 58166.0, 58405.41594584085, 59274.77614850465, 51530.48469515407, 52186.739066305185, 52565.0, 52851.73574132105, 53188.46811531913, 7734.381249500139, 7828.0, 8165.591720413837, 8321.542315172723, 8381.0, 35174.648253518164, 35839.46240806338, 36183.27633447263, 37207.81396093002, 37287.25425491421, 43321.78339108284, 44754.77622611996, 47623.28565071596, 47796.522034779206, 48517.266891959785, 11126.88873111291, 11754.647360579196, 11830.349330786888, 12021.459034343301, 12643.114981951176, 12156.574519891761, 12377.443015064164, 12571.18287311322, 12634.368281586068, 13483.258420786558, 11712.648620541397, 11872.46573904159, 12135.817962730389, 12300.753984920431, 12625.368731563569, 11658.300501969909, 11675.474603643026, 11975.580854670045, 12042.157049006486, 12224.266544007389, 10784.568617255221, 10902.0, 11059.336439813636, 11254.549818007188, 11485.138614603771, 9051.0, 9256.49089300068, 9342.766430839283, 9372.812543749224, 9555.61777528891, 10160.0, 10236.931998729162, 10265.692029239135, 10363.585456581652, 10383.428911409643], "value": 6226.771765182746, "unit": "score"}], "name": "dromaeo_css", "value": 6277.372260852032, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 114.0, 117.0, 117.0, 114.0, 116.0, 115.0, 115.0, 118.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 130.0, 125.0, 174.0, 128.0, 126.0, 125.0, 126.0, 151.0, 125.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 162.0, 161.0, 163.0, 161.0, 161.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 78.0, 109.0, 76.0, 77.0, 75.0, 75.0, 97.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 117.0, 86.0, 83.0, 85.0, 100.0, 85.0, 83.0, 108.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 149.0, 149.0, 150.0, 149.0, 149.0, 149.0, 149.0, 149.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 59.0, 58.0, 59.0, 59.0, 59.0, 60.0, 59.0, 60.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 68.0, 69.0], "value": 67.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 87.0, 86.0, 85.0, 88.0, 85.0, 90.0, 84.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 132.0, 137.0, 136.0, 141.0, 134.0, 132.0, 142.0, 173.0, 139.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 179.0, 178.0, 175.0, 175.0, 177.0, 175.0, 188.0, 176.0, 175.0], "value": 177.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 68.0, 69.0, 69.0, 69.0, 67.0, 67.0, 73.0, 67.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1546.3999999999999, "alertThreshold": 2.0}]} 07:49:56 INFO - Return code: 0 07:49:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:49:56 ERROR - # TBPL SUCCESS # 07:49:56 INFO - Running post-action listener: _resource_record_post_action 07:49:56 INFO - [mozharness: 2017-01-17 15:49:56.502981Z] Finished run-tests step (success) 07:49:56 INFO - Running post-run listener: _resource_record_post_run 07:49:56 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 2232320; Write bytes: 300056576; Read time: 436; Write time: 176248 07:49:56 INFO - TinderboxPrint: CPU usage
13.1% 07:49:56 INFO - TinderboxPrint: I/O read bytes / time
2,232,320 / 436 07:49:56 INFO - TinderboxPrint: I/O write bytes / time
300,056,576 / 176,248 07:49:56 INFO - TinderboxPrint: CPU idle
8,337.1 (86.9%) 07:49:56 INFO - TinderboxPrint: CPU user
1,213.7 (12.6%) 07:49:56 INFO - TinderboxPrint: Swap in / out
0 / 0 07:49:56 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 14729216; Read time: 0; Write time: 2964 07:49:56 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 2232320; Write bytes: 285327360; Read time: 436; Write time: 173284 07:49:57 INFO - Running post-run listener: _upload_blobber_files 07:49:57 INFO - Blob upload gear active. 07:49:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:49:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:49:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:49:57 INFO - (blobuploader) - INFO - Open directory for files ... 07:49:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:49:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:49:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:49:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:49:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:49:58 INFO - (blobuploader) - INFO - Done attempting. 07:49:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:49:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:49:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:50:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:02 INFO - (blobuploader) - INFO - Done attempting. 07:50:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:50:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:50:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:03 INFO - (blobuploader) - INFO - Done attempting. 07:50:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:50:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:50:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:04 INFO - (blobuploader) - INFO - Done attempting. 07:50:04 INFO - (blobuploader) - INFO - Iteration through files over. 07:50:04 INFO - Return code: 0 07:50:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:50:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:50:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/77399ef282d430617734a6da8d388ca1d3bb75e12d05ace283794ad2d21271ab936f68a87ac5c50979a173a2471ca66bcff7ef4d6f884da36c5bf5c88b6da565", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ca933ff197776477f2e0322b6272734635e0de6615db9c6c9a6bde5a829ecbd8523c0e7a5798446367a89a75b20b7c3665f1fc43291e69fe4c535ee91e149cc6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f014041ccb2f7093e09d6b5e817805ed41baa2c21279fe2f7bbf79499337211074839eb6ad15620062a0f20a7333ba45eb557cc1f1b5b026b75f26b28fec1c37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2a90a37ded21144e63043a10bbdefbd4f8cfc9dabbea9733eda087db4404b8d1b78810606e975101113189856a4b545b4acf6cedcdb1a888479673f98c2ce49f"} 07:50:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:50:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:50:04 INFO - Contents: 07:50:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/77399ef282d430617734a6da8d388ca1d3bb75e12d05ace283794ad2d21271ab936f68a87ac5c50979a173a2471ca66bcff7ef4d6f884da36c5bf5c88b6da565", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ca933ff197776477f2e0322b6272734635e0de6615db9c6c9a6bde5a829ecbd8523c0e7a5798446367a89a75b20b7c3665f1fc43291e69fe4c535ee91e149cc6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f014041ccb2f7093e09d6b5e817805ed41baa2c21279fe2f7bbf79499337211074839eb6ad15620062a0f20a7333ba45eb557cc1f1b5b026b75f26b28fec1c37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2a90a37ded21144e63043a10bbdefbd4f8cfc9dabbea9733eda087db4404b8d1b78810606e975101113189856a4b545b4acf6cedcdb1a888479673f98c2ce49f"} 07:50:04 INFO - Running post-run listener: copy_logs_to_upload_dir 07:50:04 INFO - Copying logs to upload dir... 07:50:04 INFO - mkdir: /builds/slave/test/build/upload/logs 07:50:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.975792 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-01-17 07:50:03.791812) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 07:50:03.795093) ========= 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=31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734 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/77399ef282d430617734a6da8d388ca1d3bb75e12d05ace283794ad2d21271ab936f68a87ac5c50979a173a2471ca66bcff7ef4d6f884da36c5bf5c88b6da565", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ca933ff197776477f2e0322b6272734635e0de6615db9c6c9a6bde5a829ecbd8523c0e7a5798446367a89a75b20b7c3665f1fc43291e69fe4c535ee91e149cc6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f014041ccb2f7093e09d6b5e817805ed41baa2c21279fe2f7bbf79499337211074839eb6ad15620062a0f20a7333ba45eb557cc1f1b5b026b75f26b28fec1c37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2a90a37ded21144e63043a10bbdefbd4f8cfc9dabbea9733eda087db4404b8d1b78810606e975101113189856a4b545b4acf6cedcdb1a888479673f98c2ce49f"} build_url:https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/B-YDCAOWQB6ZUweRWluNMg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/77399ef282d430617734a6da8d388ca1d3bb75e12d05ace283794ad2d21271ab936f68a87ac5c50979a173a2471ca66bcff7ef4d6f884da36c5bf5c88b6da565", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ca933ff197776477f2e0322b6272734635e0de6615db9c6c9a6bde5a829ecbd8523c0e7a5798446367a89a75b20b7c3665f1fc43291e69fe4c535ee91e149cc6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f014041ccb2f7093e09d6b5e817805ed41baa2c21279fe2f7bbf79499337211074839eb6ad15620062a0f20a7333ba45eb557cc1f1b5b026b75f26b28fec1c37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2a90a37ded21144e63043a10bbdefbd4f8cfc9dabbea9733eda087db4404b8d1b78810606e975101113189856a4b545b4acf6cedcdb1a888479673f98c2ce49f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 07:50:03.820897) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 07:50:03.821286) ========= 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=31acecf42b6a79ec49471d4a000001bb-1484661612.824196-1013342734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 07:50:03.903558) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 07:50:03.903989) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 07:50:03.904362) ========= ========= Total master_lag: 0.17 =========