builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1479461501.61 results: success (0) buildid: 20161118001628 builduid: cdf5008287c74756a7187500fa317dc5 revision: 2cce2032c5c1c6c7afb418779e171446873a5103 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 01:31:41.611396) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 01:31:41.611851) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 01:31:41.612126) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 01:31:41.626523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 01:31:41.626835) ========= 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-1479461501.263097-1292696603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-18 01:31: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% 40.3M=0s 2016-11-18 01:31:41 (40.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093846 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 01:31:41.733967) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 01:31:41.734273) ========= 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-1479461501.263097-1292696603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019889 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 01:31:41.783376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 01:31:41.783738) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 2cce2032c5c1c6c7afb418779e171446873a5103 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 2cce2032c5c1c6c7afb418779e171446873a5103 --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-1479461501.263097-1292696603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-18 01:31:42,112 truncating revision to first 12 chars 2016-11-18 01:31:42,112 Setting DEBUG logging. 2016-11-18 01:31:42,112 attempt 1/10 2016-11-18 01:31:42,112 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/2cce2032c5c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 01:31:42,625 unpacking tar archive at: graphics-2cce2032c5c1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.837469 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 01:31:42.634412) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 01:31:42.634751) ========= script_repo_revision: 2cce2032c5c1c6c7afb418779e171446873a5103 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 01:31:42.635138) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 01:31:42.635404) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 01:31:42.643629) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-11-18 01:31:42.643897) ========= /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-1479461501.263097-1292696603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:31:43 INFO - MultiFileLogger online at 20161118 01:31:43 in /builds/slave/test 01:31:43 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 01:31:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:31:43 INFO - {'append_to_log': False, 01:31:43 INFO - 'base_work_dir': '/builds/slave/test', 01:31:43 INFO - 'blob_upload_branch': 'Graphics', 01:31:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:31:43 INFO - 'branch': 'Graphics', 01:31:43 INFO - 'buildbot_json_path': 'buildprops.json', 01:31:43 INFO - 'config_files': ('talos/linux_config.py',), 01:31:43 INFO - 'default_actions': ('clobber', 01:31:43 INFO - 'read-buildbot-config', 01:31:43 INFO - 'download-and-extract', 01:31:43 INFO - 'populate-webroot', 01:31:43 INFO - 'create-virtualenv', 01:31:43 INFO - 'install', 01:31:43 INFO - 'run-tests'), 01:31:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:31:43 INFO - 'download_minidump_stackwalk': True, 01:31:43 INFO - 'download_symbols': 'ondemand', 01:31:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:31:43 INFO - 'tooltool.py': '/tools/tooltool.py', 01:31:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:31:43 INFO - '/tools/misc-python/virtualenv.py')}, 01:31:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:31:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:31:43 INFO - 'installer_path': 'installer.exe', 01:31:43 INFO - 'log_level': 'info', 01:31:43 INFO - 'log_name': 'talos', 01:31:43 INFO - 'log_to_console': True, 01:31:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:31:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:31:43 INFO - 'opt_config_files': (), 01:31:43 INFO - 'pip_index': False, 01:31:43 INFO - 'sps_profile': False, 01:31:43 INFO - 'sps_profile_interval': 0, 01:31:43 INFO - 'suite': 'dromaeojs', 01:31:43 INFO - 'system_bits': '32', 01:31:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:31:43 INFO - 'title': 'talos-linux64-ix-014', 01:31:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:31:43 INFO - 'use_talos_json': True, 01:31:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:31:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:31:43 INFO - 'work_dir': 'build'} 01:31:43 INFO - [mozharness: 2016-11-18 09:31:43.073373Z] Running clobber step. 01:31:43 INFO - Running pre-action listener: _resource_record_pre_action 01:31:43 INFO - Running main action method: clobber 01:31:43 INFO - rmtree: /builds/slave/test/build 01:31:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:31:43 INFO - Running post-action listener: _resource_record_post_action 01:31:43 INFO - [mozharness: 2016-11-18 09:31:43.536634Z] Finished clobber step (success) 01:31:43 INFO - [mozharness: 2016-11-18 09:31:43.536732Z] Running read-buildbot-config step. 01:31:43 INFO - Running pre-action listener: _resource_record_pre_action 01:31:43 INFO - Running main action method: read_buildbot_config 01:31:43 INFO - Using buildbot properties: 01:31:43 INFO - { 01:31:43 INFO - "project": "", 01:31:43 INFO - "product": "firefox", 01:31:43 INFO - "script_repo_revision": "default", 01:31:43 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 01:31:43 INFO - "repository": "", 01:31:43 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 01:31:43 INFO - "buildid": "20161118001628", 01:31:43 INFO - "pgo_build": "False", 01:31:43 INFO - "basedir": "/builds/slave/test", 01:31:43 INFO - "buildnumber": 8, 01:31:43 INFO - "slavename": "talos-linux64-ix-014", 01:31:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:31:43 INFO - "platform": "ubuntu64_hw", 01:31:43 INFO - "scheduler": "tests-graphics-linux64-talos", 01:31:43 INFO - "branch": "graphics", 01:31:43 INFO - "repo_path": "projects/graphics", 01:31:43 INFO - "revision": "2cce2032c5c1c6c7afb418779e171446873a5103", 01:31:43 INFO - "stage_platform": "linux64", 01:31:43 INFO - "builduid": "cdf5008287c74756a7187500fa317dc5", 01:31:43 INFO - "slavebuilddir": "test" 01:31:43 INFO - } 01:31:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 01:31:43 INFO - Running post-action listener: _resource_record_post_action 01:31:43 INFO - [mozharness: 2016-11-18 09:31:43.539139Z] Finished read-buildbot-config step (success) 01:31:43 INFO - [mozharness: 2016-11-18 09:31:43.539226Z] Running download-and-extract step. 01:31:43 INFO - Running pre-action listener: _resource_record_pre_action 01:31:43 INFO - Running main action method: download_and_extract 01:31:43 INFO - mkdir: /builds/slave/test/build/tests 01:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:31:43 INFO - trying https://queue.taskcluster.net/v1/task/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 01:31:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 01:31:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:31:44 INFO - Downloaded 1361 bytes. 01:31:44 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 01:31:44 INFO - Using the following test package requirements: 01:31:44 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 01:31:44 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:31:44 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:31:44 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:31:44 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:31:44 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:31:44 INFO - u'jsshell-linux-x86_64.zip'], 01:31:44 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:31:44 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:31:44 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 01:31:44 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:31:44 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:31:44 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:31:44 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:31:44 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:31:44 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:31:44 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:31:44 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:31:44 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:31:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 01:31:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:31:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:31:44 INFO - Http code: 200 01:31:44 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 01:31:44 INFO - x-amz-cf-id: zwEW9sP1FtT7f08wytDs5JGWmLf3w4EIINOsPwYne-QHl-zTac2IzA== 01:31:44 INFO - x-amz-version-id: J9OAOsnug89DvvquJ.mnyqeFXkOk8AyE 01:31:44 INFO - Expected file size: 20361480 01:31:44 INFO - Obtained file size: 20361480 01:31:48 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:31:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 01:31:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:31:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:31:49 INFO - Http code: 200 01:31:49 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 01:31:49 INFO - x-amz-cf-id: IEuFDzcO8Tl2N4qRkGcLqnVCkq1Ohrhj41H7pXVzg-hJiiCDWidYZA== 01:31:49 INFO - x-amz-version-id: J9OAOsnug89DvvquJ.mnyqeFXkOk8AyE 01:31:49 INFO - Expected file size: 20361480 01:31:49 INFO - Obtained file size: 20361480 01:31:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 01:31:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:31:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 01:31:54 INFO - Http code: 200 01:31:54 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 01:31:54 INFO - x-amz-cf-id: 53PViUv7wW3RAr7D8E6rwRdgk2j8mtURDwZwNd9PM8jqgJCiFAdoyA== 01:31:54 INFO - x-amz-version-id: N0tEea1ZKPbLE5cGgj1FsJUgFwws6LaG 01:31:55 INFO - Expected file size: 14409392 01:31:55 INFO - Obtained file size: 14409392 01:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:31:55 INFO - trying https://queue.taskcluster.net/v1/task/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:31:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:31:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:31:56 INFO - Downloaded 55731920 bytes. 01:31:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:31:56 INFO - mkdir: /builds/slave/test/properties 01:31:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:31:56 INFO - Writing to file /builds/slave/test/properties/build_url 01:31:56 INFO - Contents: 01:31:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:31:56 INFO - Running post-action listener: _resource_record_post_action 01:31:56 INFO - Running post-action listener: set_extra_try_arguments 01:31:56 INFO - [mozharness: 2016-11-18 09:31:56.983290Z] Finished download-and-extract step (success) 01:31:56 INFO - [mozharness: 2016-11-18 09:31:56.983515Z] Running populate-webroot step. 01:31:56 INFO - Running pre-action listener: _resource_record_pre_action 01:31:56 INFO - Running main action method: populate_webroot 01:31:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:31:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:31:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:31:56 INFO - '--tppagecycles', 01:31:56 INFO - '7'], 01:31:56 INFO - 'tests': ['tsvgm']}}, 01:31:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:31:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:31:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:31:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:31:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:31:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:31:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:31:56 INFO - 'talos_options': ['--disable-e10s'], 01:31:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:31:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:31:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:31:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:31:56 INFO - 'talos_options': ['--disable-e10s'], 01:31:56 INFO - 'tests': ['damp', 'tps']}, 01:31:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:31:56 INFO - 'tests': ['damp', 'tps']}, 01:31:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:31:56 INFO - 'tests': ['dromaeo_dom']}, 01:31:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:31:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:31:56 INFO - 'tests': ['basic_compositor_video']}, 01:31:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:31:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:31:56 INFO - 'tests': ['a11yr', 01:31:56 INFO - 'ts_paint', 01:31:56 INFO - 'tpaint', 01:31:56 INFO - 'sessionrestore', 01:31:56 INFO - 'sessionrestore_no_auto_restore', 01:31:56 INFO - 'tabpaint']}, 01:31:56 INFO - 'other-e10s': {'tests': ['a11yr', 01:31:56 INFO - 'ts_paint', 01:31:56 INFO - 'tpaint', 01:31:56 INFO - 'sessionrestore', 01:31:56 INFO - 'sessionrestore_no_auto_restore', 01:31:56 INFO - 'tabpaint']}, 01:31:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:31:56 INFO - 'ts_paint', 01:31:56 INFO - 'tpaint', 01:31:56 INFO - 'sessionrestore', 01:31:56 INFO - 'sessionrestore_no_auto_restore', 01:31:56 INFO - 'tabpaint']}, 01:31:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:31:56 INFO - 'ts_paint', 01:31:56 INFO - 'tpaint', 01:31:56 INFO - 'sessionrestore', 01:31:56 INFO - 'sessionrestore_no_auto_restore', 01:31:56 INFO - 'tabpaint']}, 01:31:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:31:56 INFO - 'tests': ['a11yr', 01:31:56 INFO - 'ts_paint', 01:31:56 INFO - 'tpaint', 01:31:56 INFO - 'sessionrestore', 01:31:57 INFO - 'sessionrestore_no_auto_restore', 01:31:57 INFO - 'tabpaint']}, 01:31:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:31:57 INFO - 'tests': ['a11yr', 01:31:57 INFO - 'ts_paint', 01:31:57 INFO - 'tpaint', 01:31:57 INFO - 'sessionrestore', 01:31:57 INFO - 'sessionrestore_no_auto_restore', 01:31:57 INFO - 'tabpaint']}, 01:31:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:31:57 INFO - 'tests': ['tsvgx', 01:31:57 INFO - 'tsvgr_opacity', 01:31:57 INFO - 'tart', 01:31:57 INFO - 'tscrollx', 01:31:57 INFO - 'cart']}, 01:31:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:31:57 INFO - 'tsvgr_opacity', 01:31:57 INFO - 'tart', 01:31:57 INFO - 'tscrollx', 01:31:57 INFO - 'cart']}, 01:31:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:31:57 INFO - 'talos_options': ['--disable-e10s'], 01:31:57 INFO - 'tests': ['tp5o']}, 01:31:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:31:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:31:57 INFO - 'talos_options': ['--disable-e10s', 01:31:57 INFO - '--xperf_path', 01:31:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:31:57 INFO - 'tests': ['tp5n']}, 01:31:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:31:57 INFO - 'talos_options': ['--xperf_path', 01:31:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:31:57 INFO - 'tests': ['tp5n']}}, 01:31:57 INFO - 'talos.zip': {'path': '', 01:31:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:31:57 INFO - Running post-action listener: _resource_record_post_action 01:31:57 INFO - [mozharness: 2016-11-18 09:31:57.002682Z] Finished populate-webroot step (success) 01:31:57 INFO - [mozharness: 2016-11-18 09:31:57.002770Z] Running create-virtualenv step. 01:31:57 INFO - Running pre-action listener: _resource_record_pre_action 01:31:57 INFO - Running main action method: create_virtualenv 01:31:57 INFO - Creating virtualenv /builds/slave/test/build/venv 01:31:57 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 01:31:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:31:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:31:57 INFO - Using real prefix '/usr' 01:31:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:31:57 INFO - Installing distribute.............................................................................................................................................................................................done. 01:31:59 INFO - Installing pip.................done. 01:31:59 INFO - Return code: 0 01:31:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:31:59 INFO - Reading from file tmpfile_stdout 01:31:59 INFO - Output received: 01:31:59 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) 01:31:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:59 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 0x7f65f800be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c9fc0>, '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 0x23caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cb350>, '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-1479461501.263097-1292696603', '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 01:31:59 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 01:31:59 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 01:31:59 INFO - Using env: {'DISPLAY': ':0', 01:31:59 INFO - 'HOME': '/home/cltbld', 01:31:59 INFO - 'LANG': 'en_US.UTF-8', 01:31:59 INFO - 'LANGUAGE': 'en_US:en', 01:31:59 INFO - 'LOGNAME': 'cltbld', 01:31:59 INFO - 'MAIL': '/var/mail/cltbld', 01:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:59 INFO - 'MOZ_NO_REMOTE': '1', 01:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:31:59 INFO - 'NO_EM_RESTART': '1', 01:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:59 INFO - 'PWD': '/builds/slave/test', 01:31:59 INFO - 'SHELL': '/bin/bash', 01:31:59 INFO - 'SHLVL': '1', 01:31:59 INFO - 'TERM': 'linux', 01:31:59 INFO - 'TMOUT': '86400', 01:31:59 INFO - 'USER': 'cltbld', 01:31:59 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479461501.263097-1292696603', 01:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:59 INFO - '_': '/tools/buildbot/bin/python'} 01:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:00 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 01:32:00 INFO - Cleaning up... 01:32:00 INFO - Return code: 0 01:32:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f65f800be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c9fc0>, '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 0x23caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cb350>, '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-1479461501.263097-1292696603', '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 01:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:32:00 INFO - Using env: {'DISPLAY': ':0', 01:32:00 INFO - 'HOME': '/home/cltbld', 01:32:00 INFO - 'LANG': 'en_US.UTF-8', 01:32:00 INFO - 'LANGUAGE': 'en_US:en', 01:32:00 INFO - 'LOGNAME': 'cltbld', 01:32:00 INFO - 'MAIL': '/var/mail/cltbld', 01:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:00 INFO - 'MOZ_NO_REMOTE': '1', 01:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:00 INFO - 'NO_EM_RESTART': '1', 01:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:00 INFO - 'PWD': '/builds/slave/test', 01:32:00 INFO - 'SHELL': '/bin/bash', 01:32:00 INFO - 'SHLVL': '1', 01:32:00 INFO - 'TERM': 'linux', 01:32:00 INFO - 'TMOUT': '86400', 01:32:00 INFO - 'USER': 'cltbld', 01:32:00 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479461501.263097-1292696603', 01:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:00 INFO - '_': '/tools/buildbot/bin/python'} 01:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:00 INFO - Downloading/unpacking psutil>=3.1.1 01:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:32:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:32:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:32:02 INFO - Installing collected packages: psutil 01:32:02 INFO - Running setup.py install for psutil 01:32:02 INFO - building 'psutil._psutil_linux' extension 01:32:02 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 01:32:02 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 01:32:02 INFO - building 'psutil._psutil_posix' extension 01:32:02 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 01:32:02 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 01:32:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:32:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:32:02 INFO - Successfully installed psutil 01:32:02 INFO - Cleaning up... 01:32:02 INFO - Return code: 0 01:32:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:02 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 0x7f65f800be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c9fc0>, '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 0x23caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cb350>, '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-1479461501.263097-1292696603', '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 01:32:02 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 01:32:02 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 01:32:02 INFO - Using env: {'DISPLAY': ':0', 01:32:02 INFO - 'HOME': '/home/cltbld', 01:32:02 INFO - 'LANG': 'en_US.UTF-8', 01:32:02 INFO - 'LANGUAGE': 'en_US:en', 01:32:02 INFO - 'LOGNAME': 'cltbld', 01:32:02 INFO - 'MAIL': '/var/mail/cltbld', 01:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:02 INFO - 'MOZ_NO_REMOTE': '1', 01:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:02 INFO - 'NO_EM_RESTART': '1', 01:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:02 INFO - 'PWD': '/builds/slave/test', 01:32:02 INFO - 'SHELL': '/bin/bash', 01:32:02 INFO - 'SHLVL': '1', 01:32:02 INFO - 'TERM': 'linux', 01:32:02 INFO - 'TMOUT': '86400', 01:32:02 INFO - 'USER': 'cltbld', 01:32:02 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479461501.263097-1292696603', 01:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:02 INFO - '_': '/tools/buildbot/bin/python'} 01:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:32:03 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 01:32:03 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 01:32:03 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 01:32:03 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 01:32:03 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 01:32:03 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 01:32:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:32:05 INFO - Installing collected packages: mozsystemmonitor 01:32:05 INFO - Running setup.py install for mozsystemmonitor 01:32:05 INFO - Successfully installed mozsystemmonitor 01:32:05 INFO - Cleaning up... 01:32:05 INFO - Return code: 0 01:32:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:32:05 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')]} 01:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:05 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')]} 01:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:05 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 0x7f65f800be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c9fc0>, '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 0x23caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cb350>, '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-1479461501.263097-1292696603', '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 01:32:05 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 01:32:05 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 01:32:05 INFO - Using env: {'DISPLAY': ':0', 01:32:05 INFO - 'HOME': '/home/cltbld', 01:32:05 INFO - 'LANG': 'en_US.UTF-8', 01:32:05 INFO - 'LANGUAGE': 'en_US:en', 01:32:05 INFO - 'LOGNAME': 'cltbld', 01:32:05 INFO - 'MAIL': '/var/mail/cltbld', 01:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:05 INFO - 'MOZ_NO_REMOTE': '1', 01:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:05 INFO - 'NO_EM_RESTART': '1', 01:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:05 INFO - 'PWD': '/builds/slave/test', 01:32:05 INFO - 'SHELL': '/bin/bash', 01:32:05 INFO - 'SHLVL': '1', 01:32:05 INFO - 'TERM': 'linux', 01:32:05 INFO - 'TMOUT': '86400', 01:32:05 INFO - 'USER': 'cltbld', 01:32:05 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479461501.263097-1292696603', 01:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:05 INFO - '_': '/tools/buildbot/bin/python'} 01:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:05 INFO - Downloading/unpacking jsonschema==2.5.1 01:32:05 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 01:32:05 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 01:32:05 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 01:32:05 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 01:32:05 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 01:32:05 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 01:32:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:32:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:32:07 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 01:32:07 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 01:32:07 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 01:32:07 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 01:32:07 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 01:32:07 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 01:32:07 INFO - Downloading functools32-3.2.3-2.tar.gz 01:32:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:32:07 INFO - warning: no files found matching '*.txt' 01:32:07 INFO - no previously-included directories found matching 'build' 01:32:07 INFO - no previously-included directories found matching 'dist' 01:32:07 INFO - no previously-included directories found matching '.git*' 01:32:07 INFO - Installing collected packages: jsonschema, functools32 01:32:07 INFO - Running setup.py install for functools32 01:32:07 INFO - warning: no files found matching '*.txt' 01:32:07 INFO - no previously-included directories found matching 'build' 01:32:07 INFO - no previously-included directories found matching 'dist' 01:32:07 INFO - no previously-included directories found matching '.git*' 01:32:07 INFO - Successfully installed jsonschema functools32 01:32:07 INFO - Cleaning up... 01:32:07 INFO - Return code: 0 01:32:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:32:07 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')]} 01:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:07 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')]} 01:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:07 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 0x7f65f800be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c9fc0>, '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 0x23caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cb350>, '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-1479461501.263097-1292696603', '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 01:32:07 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 01:32:07 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 01:32:07 INFO - Using env: {'DISPLAY': ':0', 01:32:07 INFO - 'HOME': '/home/cltbld', 01:32:07 INFO - 'LANG': 'en_US.UTF-8', 01:32:07 INFO - 'LANGUAGE': 'en_US:en', 01:32:07 INFO - 'LOGNAME': 'cltbld', 01:32:07 INFO - 'MAIL': '/var/mail/cltbld', 01:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:07 INFO - 'MOZ_NO_REMOTE': '1', 01:32:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:07 INFO - 'NO_EM_RESTART': '1', 01:32:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:07 INFO - 'PWD': '/builds/slave/test', 01:32:07 INFO - 'SHELL': '/bin/bash', 01:32:07 INFO - 'SHLVL': '1', 01:32:07 INFO - 'TERM': 'linux', 01:32:07 INFO - 'TMOUT': '86400', 01:32:07 INFO - 'USER': 'cltbld', 01:32:07 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479461501.263097-1292696603', 01:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:07 INFO - '_': '/tools/buildbot/bin/python'} 01:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:32:08 INFO - Cleaning up... 01:32:08 INFO - Return code: 0 01:32:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:08 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 0x7f65f800be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c9fc0>, '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 0x23caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cb350>, '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-1479461501.263097-1292696603', '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 01:32:08 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 01:32:08 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 01:32:08 INFO - Using env: {'DISPLAY': ':0', 01:32:08 INFO - 'HOME': '/home/cltbld', 01:32:08 INFO - 'LANG': 'en_US.UTF-8', 01:32:08 INFO - 'LANGUAGE': 'en_US:en', 01:32:08 INFO - 'LOGNAME': 'cltbld', 01:32:08 INFO - 'MAIL': '/var/mail/cltbld', 01:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:08 INFO - 'MOZ_NO_REMOTE': '1', 01:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:08 INFO - 'NO_EM_RESTART': '1', 01:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:08 INFO - 'PWD': '/builds/slave/test', 01:32:08 INFO - 'SHELL': '/bin/bash', 01:32:08 INFO - 'SHLVL': '1', 01:32:08 INFO - 'TERM': 'linux', 01:32:08 INFO - 'TMOUT': '86400', 01:32:08 INFO - 'USER': 'cltbld', 01:32:08 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479461501.263097-1292696603', 01:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:08 INFO - '_': '/tools/buildbot/bin/python'} 01:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:08 INFO - Downloading/unpacking blobuploader==1.2.4 01:32:08 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 01:32:08 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 01:32:08 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 01:32:08 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 01:32:08 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 01:32:08 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 01:32:10 INFO - Downloading blobuploader-1.2.4.tar.gz 01:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:32:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:32:10 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 01:32:10 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 01:32:10 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 01:32:10 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 01:32:10 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 01:32:10 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 01:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:32:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:32:10 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 01:32:10 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 01:32:10 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 01:32:10 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 01:32:10 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 01:32:10 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 01:32:10 INFO - Downloading docopt-0.6.1.tar.gz 01:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:32:10 INFO - Installing collected packages: blobuploader, requests, docopt 01:32:10 INFO - Running setup.py install for blobuploader 01:32:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:32:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:32:11 INFO - Running setup.py install for requests 01:32:11 INFO - Running setup.py install for docopt 01:32:11 INFO - Successfully installed blobuploader requests docopt 01:32:11 INFO - Cleaning up... 01:32:11 INFO - Return code: 0 01:32:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:32:11 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')]} 01:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:11 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')]} 01:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:11 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 0x7f65f800be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c9fc0>, '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 0x23caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cb350>, '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-1479461501.263097-1292696603', '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 01:32:11 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 01:32:11 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 01:32:11 INFO - Using env: {'DISPLAY': ':0', 01:32:11 INFO - 'HOME': '/home/cltbld', 01:32:11 INFO - 'LANG': 'en_US.UTF-8', 01:32:11 INFO - 'LANGUAGE': 'en_US:en', 01:32:11 INFO - 'LOGNAME': 'cltbld', 01:32:11 INFO - 'MAIL': '/var/mail/cltbld', 01:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:11 INFO - 'MOZ_NO_REMOTE': '1', 01:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:11 INFO - 'NO_EM_RESTART': '1', 01:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:11 INFO - 'PWD': '/builds/slave/test', 01:32:11 INFO - 'SHELL': '/bin/bash', 01:32:11 INFO - 'SHLVL': '1', 01:32:11 INFO - 'TERM': 'linux', 01:32:11 INFO - 'TMOUT': '86400', 01:32:11 INFO - 'USER': 'cltbld', 01:32:11 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479461501.263097-1292696603', 01:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:11 INFO - '_': '/tools/buildbot/bin/python'} 01:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:32:11 INFO - Running setup.py (path:/tmp/pip-otMKn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:32:11 INFO - Running setup.py (path:/tmp/pip-qFN8ES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:32:11 INFO - Running setup.py (path:/tmp/pip-MW50zU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:32:12 INFO - Running setup.py (path:/tmp/pip-meoH3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:32:12 INFO - Running setup.py (path:/tmp/pip-78EQSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:32:12 INFO - Running setup.py (path:/tmp/pip-qbOQoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:32:12 INFO - Running setup.py (path:/tmp/pip-1iZRo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:32:12 INFO - Running setup.py (path:/tmp/pip-_mHamR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:32:12 INFO - Running setup.py (path:/tmp/pip-Hy0Dmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:32:12 INFO - Running setup.py (path:/tmp/pip-Ai4snq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:32:12 INFO - Running setup.py (path:/tmp/pip-5vexFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:32:12 INFO - Running setup.py (path:/tmp/pip-oaVJ26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:32:12 INFO - Running setup.py (path:/tmp/pip-xqQ1FF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:32:12 INFO - Running setup.py (path:/tmp/pip-DeYiGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:12 INFO - Running setup.py (path:/tmp/pip-sGMBsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:32:12 INFO - Running setup.py (path:/tmp/pip-PitPD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:32:12 INFO - Running setup.py (path:/tmp/pip-WwTfiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:32:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:32:13 INFO - Running setup.py install for manifestparser 01:32:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:32:13 INFO - Running setup.py install for mozcrash 01:32:13 INFO - Running setup.py install for mozdebug 01:32:13 INFO - Running setup.py install for mozdevice 01:32:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:32:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:32:13 INFO - Running setup.py install for mozfile 01:32:13 INFO - Running setup.py install for mozhttpd 01:32:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:32:13 INFO - Running setup.py install for mozinfo 01:32:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:32:13 INFO - Running setup.py install for mozInstall 01:32:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:32:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:32:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:32:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:32:13 INFO - Running setup.py install for mozleak 01:32:13 INFO - Running setup.py install for mozlog 01:32:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:32:14 INFO - Running setup.py install for moznetwork 01:32:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:32:14 INFO - Running setup.py install for mozprocess 01:32:14 INFO - Running setup.py install for mozprofile 01:32:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:32:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:32:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:32:14 INFO - Running setup.py install for mozrunner 01:32:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:32:14 INFO - Running setup.py install for mozscreenshot 01:32:14 INFO - Running setup.py install for moztest 01:32:14 INFO - Running setup.py install for mozversion 01:32:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:32:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:32:14 INFO - Cleaning up... 01:32:14 INFO - Return code: 0 01:32:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:32:14 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')]} 01:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:14 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')]} 01:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:14 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 0x7f65f800be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c9fc0>, '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 0x23caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cb350>, '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-1479461501.263097-1292696603', '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 01:32:14 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 01:32:14 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 01:32:14 INFO - Using env: {'DISPLAY': ':0', 01:32:14 INFO - 'HOME': '/home/cltbld', 01:32:14 INFO - 'LANG': 'en_US.UTF-8', 01:32:14 INFO - 'LANGUAGE': 'en_US:en', 01:32:14 INFO - 'LOGNAME': 'cltbld', 01:32:14 INFO - 'MAIL': '/var/mail/cltbld', 01:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:14 INFO - 'MOZ_NO_REMOTE': '1', 01:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:14 INFO - 'NO_EM_RESTART': '1', 01:32:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:14 INFO - 'PWD': '/builds/slave/test', 01:32:14 INFO - 'SHELL': '/bin/bash', 01:32:14 INFO - 'SHLVL': '1', 01:32:14 INFO - 'TERM': 'linux', 01:32:14 INFO - 'TMOUT': '86400', 01:32:14 INFO - 'USER': 'cltbld', 01:32:14 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479461501.263097-1292696603', 01:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:14 INFO - '_': '/tools/buildbot/bin/python'} 01:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:32:15 INFO - Running setup.py (path:/tmp/pip-TYB_7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:32:15 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:32:15 INFO - Running setup.py (path:/tmp/pip-PwfcO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:32:15 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:32:15 INFO - Running setup.py (path:/tmp/pip-rg0RHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:32:15 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:32:15 INFO - Running setup.py (path:/tmp/pip-Ubigs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:32:15 INFO - Running setup.py (path:/tmp/pip-5z8Rur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:32:15 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:32:15 INFO - Running setup.py (path:/tmp/pip-D_fymq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:32:15 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:32:15 INFO - Running setup.py (path:/tmp/pip-4U93dC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:32:15 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:32:15 INFO - Running setup.py (path:/tmp/pip-X03rFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:32:15 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:32:15 INFO - Running setup.py (path:/tmp/pip-7jWxgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:32:15 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:32:15 INFO - Running setup.py (path:/tmp/pip-IriZrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:32:15 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:32:15 INFO - Running setup.py (path:/tmp/pip-kIZFcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:32:15 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:32:15 INFO - Running setup.py (path:/tmp/pip-D53F7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:32:15 INFO - Running setup.py (path:/tmp/pip-fJiyU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:32:16 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)) 01:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:32:16 INFO - Running setup.py (path:/tmp/pip-0tmv7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:32:16 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)) 01:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:16 INFO - Running setup.py (path:/tmp/pip-LVp8pO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:16 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)) 01:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:32:16 INFO - Running setup.py (path:/tmp/pip-abk4cX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:32:16 INFO - Running setup.py (path:/tmp/pip-Hb0TXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:32:16 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)) 01:32:16 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)) 01:32:16 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)) 01:32:16 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)) 01:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:32:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:18 INFO - Downloading blessings-1.6.tar.gz 01:32:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:32:18 INFO - Installing collected packages: blessings 01:32:18 INFO - Running setup.py install for blessings 01:32:18 INFO - Successfully installed blessings 01:32:18 INFO - Cleaning up... 01:32:18 INFO - Return code: 0 01:32:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:32:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:32:18 INFO - Reading from file tmpfile_stdout 01:32:18 INFO - Current package versions: 01:32:18 INFO - argparse == 1.2.1 01:32:18 INFO - blessings == 1.6 01:32:18 INFO - blobuploader == 1.2.4 01:32:18 INFO - docopt == 0.6.1 01:32:18 INFO - functools32 == 3.2.3-2 01:32:18 INFO - jsonschema == 2.5.1 01:32:18 INFO - manifestparser == 1.1 01:32:18 INFO - mozInstall == 1.12 01:32:18 INFO - mozcrash == 1.0 01:32:18 INFO - mozdebug == 0.1 01:32:18 INFO - mozdevice == 0.48 01:32:18 INFO - mozfile == 1.2 01:32:18 INFO - mozhttpd == 0.7 01:32:18 INFO - mozinfo == 0.9 01:32:18 INFO - mozleak == 0.1 01:32:18 INFO - mozlog == 3.4 01:32:18 INFO - moznetwork == 0.27 01:32:18 INFO - mozprocess == 0.23 01:32:18 INFO - mozprofile == 0.28 01:32:18 INFO - mozrunner == 6.13 01:32:18 INFO - mozscreenshot == 0.1 01:32:18 INFO - mozsystemmonitor == 0.3 01:32:18 INFO - moztest == 0.7 01:32:18 INFO - mozversion == 1.4 01:32:18 INFO - psutil == 3.1.1 01:32:18 INFO - requests == 1.2.3 01:32:18 INFO - wsgiref == 0.1.2 01:32:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:18 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 0x7f65f800be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c9fc0>, '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 0x23caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cb350>, '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-1479461501.263097-1292696603', '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 01:32:18 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 01:32:18 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 01:32:18 INFO - Using env: {'DISPLAY': ':0', 01:32:18 INFO - 'HOME': '/home/cltbld', 01:32:18 INFO - 'LANG': 'en_US.UTF-8', 01:32:18 INFO - 'LANGUAGE': 'en_US:en', 01:32:18 INFO - 'LOGNAME': 'cltbld', 01:32:18 INFO - 'MAIL': '/var/mail/cltbld', 01:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:18 INFO - 'MOZ_NO_REMOTE': '1', 01:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:18 INFO - 'NO_EM_RESTART': '1', 01:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:18 INFO - 'PWD': '/builds/slave/test', 01:32:18 INFO - 'SHELL': '/bin/bash', 01:32:18 INFO - 'SHLVL': '1', 01:32:18 INFO - 'TERM': 'linux', 01:32:18 INFO - 'TMOUT': '86400', 01:32:18 INFO - 'USER': 'cltbld', 01:32:18 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479461501.263097-1292696603', 01:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:18 INFO - '_': '/tools/buildbot/bin/python'} 01:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:18 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)) 01:32:18 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)) 01:32:18 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)) 01:32:18 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)) 01:32:18 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)) 01:32:18 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)) 01:32:18 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)) 01:32:18 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)) 01:32:18 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)) 01:32:18 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)) 01:32:18 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)) 01:32:18 INFO - Cleaning up... 01:32:18 INFO - Return code: 0 01:32:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f65f800be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c9fc0>, '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 0x23caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cb350>, '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-1479461501.263097-1292696603', '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 01:32:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:32:18 INFO - Using env: {'DISPLAY': ':0', 01:32:18 INFO - 'HOME': '/home/cltbld', 01:32:18 INFO - 'LANG': 'en_US.UTF-8', 01:32:18 INFO - 'LANGUAGE': 'en_US:en', 01:32:18 INFO - 'LOGNAME': 'cltbld', 01:32:18 INFO - 'MAIL': '/var/mail/cltbld', 01:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:18 INFO - 'MOZ_NO_REMOTE': '1', 01:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:18 INFO - 'NO_EM_RESTART': '1', 01:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:18 INFO - 'PWD': '/builds/slave/test', 01:32:18 INFO - 'SHELL': '/bin/bash', 01:32:18 INFO - 'SHLVL': '1', 01:32:18 INFO - 'TERM': 'linux', 01:32:18 INFO - 'TMOUT': '86400', 01:32:18 INFO - 'USER': 'cltbld', 01:32:18 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479461501.263097-1292696603', 01:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:18 INFO - '_': '/tools/buildbot/bin/python'} 01:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:32:19 INFO - Cleaning up... 01:32:19 INFO - Return code: 0 01:32:19 INFO - Running post-action listener: _resource_record_post_action 01:32:19 INFO - Running post-action listener: _start_resource_monitoring 01:32:19 INFO - Starting resource monitoring. 01:32:19 INFO - [mozharness: 2016-11-18 09:32:19.221713Z] Finished create-virtualenv step (success) 01:32:19 INFO - [mozharness: 2016-11-18 09:32:19.222236Z] Running install step. 01:32:19 INFO - Running pre-action listener: _resource_record_pre_action 01:32:19 INFO - Running main action method: install 01:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:32:19 INFO - Reading from file tmpfile_stdout 01:32:19 INFO - Detecting whether we're running mozinstall >=1.0... 01:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:32:19 INFO - Reading from file tmpfile_stdout 01:32:19 INFO - Output received: 01:32:19 INFO - Usage: mozinstall [options] installer 01:32:19 INFO - Options: 01:32:19 INFO - -h, --help show this help message and exit 01:32:19 INFO - -d DEST, --destination=DEST 01:32:19 INFO - Directory to install application into. [default: 01:32:19 INFO - "/builds/slave/test"] 01:32:19 INFO - --app=APP Application being installed. [default: firefox] 01:32:19 INFO - mkdir: /builds/slave/test/build/application 01:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:32:35 INFO - Reading from file tmpfile_stdout 01:32:35 INFO - Output received: 01:32:35 INFO - /builds/slave/test/build/application/firefox/firefox 01:32:35 INFO - Running post-action listener: _resource_record_post_action 01:32:35 INFO - [mozharness: 2016-11-18 09:32:35.616583Z] Finished install step (success) 01:32:35 INFO - [mozharness: 2016-11-18 09:32:35.616837Z] Running run-tests step. 01:32:35 INFO - Running pre-action listener: _resource_record_pre_action 01:32:35 INFO - Running main action method: run_tests 01:32:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:32:35 INFO - Python 2.7.3 01:32:35 INFO - Return code: 0 01:32:35 INFO - grabbing minidump binary from tooltool 01:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:35 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 0x23c9fc0>, '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 0x23caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cb350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:32:35 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 01:32:35 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 01:32:35 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 01:32:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:32:35 INFO - Return code: 0 01:32:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:32:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:32:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:32:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:32:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:32:35 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/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.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 01:32:35 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/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.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 01:32:35 INFO - Using env: {'DISPLAY': ':0', 01:32:35 INFO - 'HOME': '/home/cltbld', 01:32:35 INFO - 'LANG': 'en_US.UTF-8', 01:32:35 INFO - 'LANGUAGE': 'en_US:en', 01:32:35 INFO - 'LOGNAME': 'cltbld', 01:32:35 INFO - 'MAIL': '/var/mail/cltbld', 01:32:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:32:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:35 INFO - 'MOZ_NO_REMOTE': '1', 01:32:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:35 INFO - 'NO_EM_RESTART': '1', 01:32:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:35 INFO - 'PWD': '/builds/slave/test', 01:32:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:32:35 INFO - 'SHELL': '/bin/bash', 01:32:35 INFO - 'SHLVL': '1', 01:32:35 INFO - 'TERM': 'linux', 01:32:35 INFO - 'TMOUT': '86400', 01:32:35 INFO - 'USER': 'cltbld', 01:32:35 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479461501.263097-1292696603', 01:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:35 INFO - '_': '/tools/buildbot/bin/python'} 01:32:35 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/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.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 01:32:35 INFO - mozversion application_buildid: 20161118001628 01:32:35 INFO - mozversion application_changeset: 2cce2032c5c1c6c7afb418779e171446873a5103 01:32:35 INFO - mozversion application_display_name: Nightly 01:32:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:32:35 INFO - mozversion application_name: Firefox 01:32:35 INFO - mozversion application_remotingname: firefox 01:32:35 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 01:32:35 INFO - mozversion application_vendor: Mozilla 01:32:35 INFO - mozversion application_version: 53.0a1 01:32:35 INFO - mozversion platform_buildid: 20161118001628 01:32:35 INFO - mozversion platform_changeset: 2cce2032c5c1c6c7afb418779e171446873a5103 01:32:35 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 01:32:35 INFO - mozversion platform_version: 53.0a1 01:32:35 INFO - using testdate: 1479461555 01:32:35 INFO - actual date: 1479461555 01:32:35 INFO - starting webserver on 'localhost:38893' 01:32:35 INFO - SUITE-START | Running 2 tests 01:32:35 INFO - TEST-START | dromaeo_css 01:32:35 INFO - operating with platform_type : linux_ 01:32:35 INFO - Initialising browser for dromaeo_css test... 01:32:35 INFO - TEST-INFO | started process 4629 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0EAn0S/profile http://localhost:38893/getInfo.html) 01:32:40 INFO - PROCESS | 4629 | __metrics Screen width/height:1600/1200 01:32:40 INFO - PROCESS | 4629 | colorDepth:24 01:32:40 INFO - PROCESS | 4629 | Browser inner width/height: 1024/697 01:32:40 INFO - PROCESS | 4629 | __metrics 01:32:40 INFO - PROCESS | 4629 | 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" 01:32:40 INFO - PROCESS | 4629 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:32:41 INFO - TEST-INFO | 4629: exit 0 01:32:41 INFO - Browser initialized. 01:32:41 INFO - Running cycle 1/1 for dromaeo_css test... 01:32:41 INFO - TEST-INFO | started process 4712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0EAn0S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:32:54 INFO - PROCESS | 4712 | RSS: Main: 174858240 01:32:54 INFO - PROCESS | 4712 | 01:33:45 INFO - PROCESS | 4712 | 1479461625759 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:35:58 INFO - PROCESS | 4712 | Cycle 1(1): loaded http://localhost:38893/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38893/tests/dromaeo/cssquery-ext.html) 01:36:00 INFO - PROCESS | 4712 | RSS: Main: 313589760 01:36:00 INFO - PROCESS | 4712 | 01:39:02 INFO - PROCESS | 4712 | Cycle 1(1): loaded http://localhost:38893/tests/dromaeo/cssquery-ext.html (next: http://localhost:38893/tests/dromaeo/cssquery-jquery.html) 01:39:03 INFO - PROCESS | 4712 | RSS: Main: 276320256 01:39:03 INFO - PROCESS | 4712 | 01:42:05 INFO - PROCESS | 4712 | Cycle 1(1): loaded http://localhost:38893/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38893/tests/dromaeo/cssquery-mootools.html) 01:42:06 INFO - PROCESS | 4712 | RSS: Main: 278822912 01:42:06 INFO - PROCESS | 4712 | 01:45:08 INFO - PROCESS | 4712 | Cycle 1(1): loaded http://localhost:38893/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38893/tests/dromaeo/cssquery-prototype.html) 01:45:09 INFO - PROCESS | 4712 | RSS: Main: 222556160 01:45:09 INFO - PROCESS | 4712 | 01:48:12 INFO - PROCESS | 4712 | Cycle 1(1): loaded http://localhost:38893/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38893/tests/dromaeo/cssquery-yui.html) 01:48:13 INFO - PROCESS | 4712 | RSS: Main: 219791360 01:48:13 INFO - PROCESS | 4712 | 01:51:16 INFO - PROCESS | 4712 | Cycle 1(1): loaded http://localhost:38893/tests/dromaeo/cssquery-yui.html (next: http://localhost:38893/tests/dromaeo/cssquery-dojo.html) 01:51:16 INFO - PROCESS | 4712 | RSS: Main: 319094784 01:51:16 INFO - PROCESS | 4712 | 01:51:16 INFO - PROCESS | 4712 | __start_tp_report 01:51:16 INFO - PROCESS | 4712 | _x_x_mozilla_page_load 01:51:16 INFO - PROCESS | 4712 | _x_x_mozilla_page_load_details 01:51:16 INFO - PROCESS | 4712 | |i|pagename|runs| 01:51:16 INFO - PROCESS | 4712 | |0;dojo.html;2509.849409035458;2539.1240022192337;2562.9359266018355;2566.5636841736905;2581.1095172165597;4352.281873490878;4419.62433193179;4517.435320584927;4539.568740969607;4565.84019559315;4456.955430445694;4497.482789479211;4553.112143132091;4554.567316104964;4567.977160114203;4163.708540402173;4193.2242535130945;4202.852900148496;4224.704270701052;4244.469441319835;3901.55132159801;4258.850940217093;4312.913741725163;4334.5448727883595;4378.6715996300245;4109.6506796922295;4197.433346498215;4200.15996800638;4271.103068355634;4290.013296941705;4154.709170358076;4203.62167404935;4208.284591619401;4209.515905670856;4211.789410529492;4188.225178342016;4196.601322874352;4197.874063778091;4198.6641068714425;4203.684723645708;4587.311903214511;4591.586757191835;4595.103954728829;4619.3994780678295;4650.116477869194;4898.485659005789;4901.901961960776;4904.779284932151;4905.092557876768;4949.876253093666;4727.621790256771;4771.570558649738;4912.877178070541;4939.283803848458;4992.725400102993;4522.3668686383935;4552.317152427129;4580.610648094949;4600.2869555218995;4646.070785842845;5029.119904016782;5033.245013248042;5035.974820125949;5039.44566097729;5086.033653605803;4782.115308667908;4802.9452771864535;4813.374261346073;4847.636427267898;4887.340209071801;4716.056788642285;4731.597814185833;4748.715077095385;4765.785539650724;4768.47546769855;4695.131400690883;4715.269133284346;4720.12677654635;4749.453812811502;4764.904701905943;4697.647676424282;4699.553542413465;4700.482946875841;4739.526047395233;4741.620670346364;4014.3175660137845;4031.1333063390925;4031.778252196157;4100.7334523255895;4103.158852435244;3587.121155316964;3633.7274704397278;3637.399829028234;3639.490471334015;3682.8526858925343;4176.331786914079;4182.414461975326;4183.330667093251;4214;4217.493900731932;4660.347551342815;4876.853694389174;4894.412670479565;4899.58353539946;4930.309756634074;4020.9597904020584;4070.430139780433;4176.686748493875;4189.287821070426;4218.620324170839;4428.512863585003;4444.266695995189;4461.219286624828;4487.461504619401;4493.550644935481;4592.862214133581;4599.586037256663;4607.193741095228;4608.861734147981;4652.3719297895705;4696.553827386393;4701.294805779161;4743.715377077387;4924.63065270099;4945;4453.176162409835;4469.150861336336;4502.752348620857;4512.593866552026;4555.658325625657;4759.357486739246;4760.928586071281;4761;4761.452432970253;4813.109574728686;4725.527447255247;4819.95180048195;4825;4832.540908613676;4872.585830204331;4623.745693986863;4686.484486706528;4705.858824235278;4714.38712967312;4718.8584342469785;4735.928961065656;4736.976315118402;4741.099191153669;4757.3101900224965;4780.856574302777;4664.416947881515;4674.275487299474;4689.179393606173;4711.905761884812;4749.715017098985;4616.907661846812;4679.27471241958;4691.859244222543;4722.1972264714395;4768.809247630056;4712.81148754046;4731.716097034189;4751.477337492942;4764.785584648768;4767.165745994506 01:51:16 INFO - PROCESS | 4712 | |1;ext.html;565.8443927919822;570.60913274407;574.112995422073;576.0322657934668;589.5254320272181;22109.447263818412;27326;28139.577906331397;28172.154835354922;30522.694773052262;28485.145445636663;28765.280867978312;28801.991930282446;28813.56779648307;28836.279093022633;5364.061289274381;5501.559875209973;5502.257195278627;5505.091659876116;5506.531944784698;4773.06925149596;4916.164252077156;5473.261109750192;5599.944000560004;5631.887362252753;5625.718714064301;5640.858978525549;5652.321721393439;5652.576056795736;5665.263515742969;5575.275214222145;5599.916001259984;5615.354234263071;5620.100783874561;5637.069883469223;5515.255440515519;5548.44515548446;5558.388577256498;5569.944300556983;5570.303712035996;26238.475230495475;26372;26531.602025969627;26550;26550.6017409739;2866.3550701092295;3033.605631267943;3178.523221516791;3258.1691668624585;3490.89527314181;17849.910750446295;17966.19152138144;18115.456536303933;18575.164117614604;18629.62740745191;2721.931951701223;2768.4739899419046;2779.1523585306472;2779.81931174473;2846.188836181699;170261;170868;171099;171298.14350928165;233341;31065;51022.234666480035;51349.74325128425;51352.229716554284;51412.485875141516;31329.216769580944;33135.171620709196;33233.16917077044;33239.83380083084;33279.66720332814;11984.340861252715;12141.210821296587;12149.331786751813;12161.087918406154;12164.330961797186;8192.34461243099;9361.017093205252;9388;9438.292128090421;9442.90557094434;7023.964880175567;7595.772126836204;7810.687572497037;7818.296353328228;7896.170902055316;3032.86352114151;3041.5893854329383;3059.602251707264;3076.200187951149;3085.460044492205;822.8066404394963;847.4660963592897;864.6671031652859;911.9863202051974;977.3647129365969;26680;27846;28276;28341.282564135716;28635.14094577166;921.5530467723149;949.544218774978;1038.4548112241134;1041.44282808697;1046.706922061824;14287.85712142886;14763.409463621334;14875.628109297355;15036.924815375853;15205.923970380078;345180;348484;349511;349604;349994;44609.77695111569;45406;45431;45447;45515.31727024097;1066.1630619963291;1086.2613422872523;1107.125370956935;1130.8416821644976;1139.2367114033618;23570.410739731644;26851;27459.588106178824;27747.438056170755;28155.155345339674;40731.38902916399;41115.1776964465;41249.381259281734;41261;41279.380809287286;265863;267866;267929;268593;268916;23356.76643233546;23433.06267749339;24308;24334.391640209138;25065.373365666004;37080.44379334258;37580.81209593934;37854.43218351782;37908.43137352887;39253.41119883261;31794.68205317917;32823.74820028784;33141.337173256885;33258;33788.83105584457;32322.676773232906;32333.35333293368;32648.34703305968;33160;33556.1610959728;32726.672733272364;32882;32928.67071329256;32967.67032329646;33344.49983250302;25851.353716156493;27016.594751078355;29683.257918552208;30075.398492030476;30160.84919575388;23721.288361349187;24187.63718544188;24188.274351769476;24444.877775611007;24623.261302160965 01:51:16 INFO - PROCESS | 4712 | |2;jquery.html;339.6938770427708;352.88354842901845;357.64771699875627;366.8404244153794;382.56960918966143;9675.27435442342;11349.319040857545;11461.942690286536;11814.350210738417;12626.30555319457;13948.163110213394;14131.576052718408;14178.361973711182;14195.219262940534;15478;3901.1807520420743;4166.020985068507;4167.124903770212;4170.97914510427;4181.477315335583;3600.6579374959338;3799.7910114943666;3833.7891415972113;4111.075008123178;4122.773247471388;3864.2271545690833;3866.4007078902814;3871.748336358142;3873.8256778444897;3874.8256328465286;3861.3435715928217;3873.302805495038;3875.7093218008763;3877.922441551153;3879.7478163919254;3316.1543806329473;3561.5013898054294;3585.175409655768;3621.94567081494;3624.5106910567;9926.751831204205;10057.798844023151;10125.949370253174;10128.493575321278;10130.392176469435;1695.355764809377;1745.4589077386051;1799.5321216483808;1802.7836659600932;1865.3844231403605;7450.18048014718;7846.7052936265445;7911.28798408146;8078.474899131537;8323.375746819012;1308.5616318533303;1389.1179101270766;1414.5897689669982;1420.3821337718125;1432.3554400519704;56529;57314.713426433016;61905.6904715478;62196.37803621951;66284.33715662878;9058.32062595308;9133.862992055125;9859.112679858847;9987.600495980225;10131.93614670449;11013.118950483942;12102.576409825613;12684.87315126837;13530.323483825769;13712.725745485035;6753.898691519631;6795.490338224653;6941;6954.374106330454;7151.89272160918;6547.607143571401;6601.603903765789;6770.086038384854;6791.728330866808;6819.215790184093;3809.9047523811573;3908;3992.2414741199077;4038.6365227129113;4055.229506393776;1728.8616910647117;1789.5526118470382;1822.6354729054242;1824.1153040775214;1831.3773317071993;806.9636866341028;809.0372456776535;822.9053658829191;845.923258400625;864.8745931839974;15572.299246533707;16220.188990550425;16843.494695159166;16951.830481695273;17254.568635783955;801.4269797095105;813.7924829168525;824.2046425199711;833.2792134803351;846.7840700621302;8862.379633425599;9144.131307525775;9151.130642588943;9468.90531094694;9670.613175473043;352851;353843;357453;364231.86898882204;368304;45590.31614525785;52526;70310;77917;78482.21517784863;861.1947828780111;889.768660148366;890.4879694175875;891.0777345447431;894.1639567004871;14824.851751482347;14839.92580037093;14929.626759331104;15026.549203523911;15483.690326193639;22652.660210096532;32560.51159232661;34308.82845585756;36316.27367452583;36330.27339453249;45407.318890217335;46017;46362.7681861602;48325.5167448321;49265.75367123142;6895.793126206222;6950.93049069523;7048.682809273492;7151.320624540868;7359.926400735924;10125.949370253396;11732.296062236293;11763.47064382122;11845.348505832262;11934.28394296345;9442.52787360643;9520.952395238257;9731.172850307803;10009.249306302203;10034.849477257701;8695.130486951255;8817.16236957488;8868.290536757173;10556.947215264181;10557.788844223227;9695.9030409695;9743.171830394496;9744.464054476788;9846.753831154278;9900.733535321171;6735.49483788708;6784.660766961731;7058.929410705828;7068.187158476635;7203.783886483414;9111.362204645611;9640.517974101127;9744;9953.601855925972;10037.34757240777 01:51:16 INFO - PROCESS | 4712 | |3;mootools.html;1306.3598836570077;1359.5921223632909;1404.480342273359;1563.53875606696;1648.0358989990855;5932.881342373155;6289.276733175686;6295.559310848237;6300.905486417708;6307.747690092397;5412.188171774226;5556.333240011194;5935.317438494574;6161.045038019103;6226.190595222614;1716.9313227470918;1749.597592553707;1753.6142048749255;1756.6223261998668;1757.4639734880857;1761.7005109131478;1766.2052076565597;1768.3722278591108;1771.6191018930926;1819.672458957387;1513.8940274180757;1543.7838702581648;1699.1928833803968;1712.1524845201643;1725.6721222967658;1635.5502236884834;1647.2093395170266;1647.6128109894166;1648.5960939569882;1650.2656317938522;1666.5500314915025;1676.0865328396053;1682.0328311221097;1696.575856035991;1698.8046374666949;6117.418845209698;6156.4766994805495;6191.876162476725;6192.9380706192815;6196.504279657616;4044.858429954967;4167.1457351242925;4176.18564379946;4178.91642167155;4181.289180839264;2512.484940587175;2710.864456777173;2727.9045233416737;2766.6265054217824;2783.74946254836;768.3123604374053;816.4529765057425;821.2075347289893;833.2167762303476;845.9873101903477;8423.452475589067;8451.83096338076;8466.74599762008;8475.533845638487;8483.321334293303;3499.650034996531;3701.796401197906;3857.3056849767313;3867.2845523577666;3876.496055512822;7365.926340736632;7375.336219740249;7380.188179300273;7381.852362952711;7397.038385009914;4191.958080419156;4194.2869712149;4198.118395137056;4201.180769749931;4202.684798640114;3720.8697695580527;3828.9234215315537;3857.0935830079907;3861.2470568239487;3861.9034524137123;3227.3545290941906;3263.461528847761;3338.198832280284;3362.0586235854;3366.074329559342;1077.6228320087907;1100.8533359948133;1107.5791199344358;1108.2020944919645;1118.3904771899333;678.220046946016;697.3375293471223;729.4930023633524;751.6241879060469;759.3128218961848;4337.522872484024;4375.387445757597;4422.513523512411;4429.269170586882;4548.931766023512;401.33979603552575;402.82477122451826;403.7436227995244;406.06604808939323;412.3196725403049;3003.339265361617;3072.4776787946103;3112.2375018120706;3145.543896135048;3158.98420507896;7293.9635301823155;7872.094709108525;7933.325667318227;7941.166177551389;7944.523328600187;7896.170902055316;7901.091374491892;7905.644246008944;7907.802304942307;7914;5978.910316345258;6164.537659675542;6197.225346831736;6215.564910456315;6235.407636274546;4581.702189357681;4641.419822522184;4656.883577910444;4685.718856868599;4786.521347865186;7254.89117663246;7343.522671026366;7389.408847292097;7400.333969942731;7411.62941852916;6884.4148247397525;7145.4998150128995;7392.260773922565;7393.741219057307;7399.889001664872;5748.137779333133;5867.618604790675;5873.236479257669;5873.765049398147;5876.882462350814;6299.149614802126;6353.809385718436;6374.808755737336;6376.234851817811;6379.904301435389;5735.8566035849435;5779.566532510163;5801.1878337032;5869.647821130746;5898.557608179318;5707.258056452634;5718.256626638677;5727.341355744143;5729.455701708331;5873.94126058751;5232.581393488588;5291.735413229246;5307.4427185145005;5310.522053015247;5320.494553017457;4144.33690609501;4176.206520761046;4196.244675958357;4286.742795432284;4344.695871288979;3884.1066554693143;3973.980130099447;4034.7780872052317;4068.6541643960595;4135.214309281227 01:51:16 INFO - PROCESS | 4712 | |4;prototype.html;278.9832610043397;287.09564870657425;289.78121518253715;292.07849235661496;295.98816047358105;4769.23692209247;4780;4781.90436191276;4814.566688997989;4820.903581928359;4764.356811830402;4767.499412561674;4768.666193366465;4772.451168115667;4777.9761101194445;3510.192655689193;3619.932120024586;3627.292677927805;3725.8323375448035;3727.7763334199967;3698.6369763842404;3717.7397582169124;3724.5530536335677;3726.329260733067;3732.104294969215;3681.785010946395;3682.2451397463456;3683.4474828775765;3694.7598406103652;3704.259148170363;3515.244222492151;3556.484309775094;3628.727845411605;3698.7041036716996;3706.4996225509617;3233.676632336771;3236.1909522619344;3243.6269828969735;3245.815277423747;3250.837458127084;4582.335561343587;4596.724196548184;4602.884927876797;4603.470600880908;4622.2835460503675;4144.342263094786;4181.749095054306;4210.473690788652;4221.704480686353;4227.450431443924;4672.3692301539195;4888.755562221911;4923.286123512106;4938;4948.678335908155;3455.9654403456148;3458.706009989154;3469.8612055517747;3485.4946032825096;3490.4764285357146;5113.795448182068;5173.715445650488;5214.40960507049;5221.686698798047;5232.686038837682;3448.9482657760154;3527.3298073365977;3548.2548664780684;3552.3960926642535;3561.0919215600375;3598.5501812273465;3598.838052287653;3598.9100272492874;3606.4770608261656;3606.945895811565;4148.62662360389;4159.9792001040405;4161.479815023122;4181.121964387513;4184.28867092595;4897.534734200245;4989.301497790312;5004.249362595567;5010.8703800885205;5027.145385284511;1212.1575505023923;1220.3288191494642;1225.2036176485178;1227.7360367520848;1228.4594778297699;793.7182300283316;832.3050253038781;840.4873027453249;842.1536355962219;847.1359213602092;4145.471262529854;4176.18564379943;4233.280342341809;4240.734634331548;4305.590968858016;4983.426905905795;5097.235414687826;5105.948940510547;5126.948730512721;5136.563392111638;4356.3683265926265;4357.368181613711;4365.650747940157;4367.323064924942;4385.101054283864;2511.8116141289474;2611.843289402642;2614.6208799724313;2629.8027647926483;2641.656584643984;4592.196365636;4605.355250264965;4609.294561012447;4614.238650622677;4635.8841028973875;5044.899102017939;5074.549306471635;5084.33903592538;5090.338256026767;5109.616778741535;4463.754493502824;4618.475902952017;4631.235846085426;4652.837150699709;4779.593734532465;5123.820666276662;5141.203113517261;5148.253503242084;5152.742362881916;5204.1673332266655;5051.87370315745;5057.949420505748;5061.772220250024;5067.69593824357;5077;4640.535946405333;4746.359241502491;4780.11567859947;4805.783739731791;4865.1242776300605;3571.428571428559;3571.8392672329287;3601.063723431979;3609.314230296235;3611.8555257789394;5166.951498615835;5174.379074511083;5204.193350030751;5205.427402985744;5217.530422262014;4767.475577686521;5017.297578339108;5051.242313652834;5074.16276314404;5097.770600323069;5020.523050310215;5022.347094877642;5024.708815725706;5027.899442011066;5039.571636410946;4953.678010929278;4965.354503914468;4965.950340496549;4977.680914557717;5005.374328208974;4944.777485013255;5013.724245166405;5036.338008457274;5087.0735593033705;5113.590912727047;4700.45944716362;4752.239641657457;4811.518848115161;4899.706017638953;4928.753562321798 01:51:16 INFO - PROCESS | 4712 | |5;yui.html;634.65094198191;651.8924377477716;658.2430205263948;658.9505787065968;715.7530651925088;10301.433421161833;11137.83293250601;11758.882411175886;11775.116866235034;11783.29300241985;10938.507767150477;11376.260543064716;11394.088472922167;11399.601013964513;11405.08759299256;607.6566739792025;721.8267615772203;750.5834261984596;760.6615056299948;761.2159475739996;625.9687015649222;736.282124928196;756.5044895593395;768.3852917665873;770.0028463140247;804.8832919226709;807.6365635464035;811.6753298680545;812.1999830167281;812.5165526511717;644.8613548087137;804.1315379390273;804.5896592737687;805.2470939671397;805.2832978649008;485.1461427886909;566.2016556655137;583.2243116654839;588.6409290332894;593.1962191230863;10487.951204879528;10510.10664093553;10536.789264214749;10543.630972915911;10550.366977981346;8674.436161649535;8895.644174233023;9119;9140.817183656356;9416.576254068583;8094.433389662726;8106.756797296091;8161.8367632647605;8294.129116442808;8332.083470818205;2455.7789798918006;2503.173952595639;2509.736477669855;2518.055729101587;2526.2547548473062;47232.291515627294;48774.51225487735;49022;50304;50576.24135637969;7151.570905745672;7173.856522869513;7190.568565886064;7209.71161153548;7231;13778.379972901244;13834.446622135001;13851.653708657162;13856.653583660489;13901.930490347484;6068.089786532056;6085.421884920926;6427.132337134521;6678.565893216925;6725.9663701681175;3661.9267614647556;3676;3719.5143113543445;3761.9435708464393;3844.3464611016193;2732.180345896263;2819.7744180465925;2832.178668186244;2836.2342167615043;2845.9857700711777;488.3041665626468;490.35763150273254;491.9237518184687;498.9276554899519;504.3090965377383;462.5767422808093;507.57617389480197;528.5269683633127;547.8356493052069;556.7967691792547;6726.39462448382;7038.964805175941;7188.784336469915;7360.521566098187;7405.074365704287;442.9003474218275;487.0575436530325;576.7289373994216;580.8083332500265;586.548357764519;3350.2127000155433;3507.5615548056494;3557.1996300832625;3608.350496910581;3714.609965953536;53653;55402.44597554053;56091.439085608625;74307;76784;50665.24002139971;52838.73580632072;54521.72739136358;55110.72444637831;56412.43587564072;43989.12021759547;44396;44402.5578593174;44892.77553612211;45010.77494612506;7109.537880037781;7377.225391333833;7608.163102058658;7679.961600191963;7829.217078292125;26926.865365673046;27990.720092798812;29003.854980724962;34878;37151.25697485981;36070.4589431164;41252.1749565013;42666.78666606647;46259.76870115628;46688.53311466842;10028.648997285352;10031.347962382422;10309.896901030894;10419.166466682798;10747.90415868898;10276.126529245097;10510.894891050992;10689.51897164614;10779.472621498833;11235.325880447199;9386.15524602789;9413.48225847585;9567.9043209567;9672.129508344282;9795.85306220393;10064.748381290527;10125.52633669638;10290.434026128634;10434.247364136574;10491.895081049397;8989.153583279523;9108.635654573744;9187.494687791968;9496;9710.17463515609;8024.679012839654;8082.757517274491;8168.877466837884;8318.209770071833;8645.697400590949;7830.4518683691595;8662.82674346522;8796.868046979429;8981.46111233302;9105.089491050841 01:51:16 INFO - PROCESS | 4712 | __end_tp_report 01:51:16 INFO - PROCESS | 4712 | __start_cc_report 01:51:16 INFO - PROCESS | 4712 | _x_x_mozilla_cycle_collect,1438 01:51:16 INFO - PROCESS | 4712 | __end_cc_report 01:51:16 INFO - PROCESS | 4712 | __startTimestamp1479462676408__endTimestamp 01:51:16 INFO - PROCESS | 4712 | 01:51:16 INFO - PROCESS | 4712 | ------- Summary: start ------- 01:51:16 INFO - PROCESS | 4712 | Number of tests: 6 01:51:16 INFO - PROCESS | 4712 | 01:51:16 INFO - PROCESS | 4712 | [#0] dojo.html Cycles:165 Average:4486.57 Median:4619.40 stddev:462.20 (10.0%) stddev-sans-first:436.83 01:51:16 INFO - PROCESS | 4712 | Values: 2509.8 2539.1 2562.9 2566.6 2581.1 4352.3 4419.6 4517.4 4539.6 4565.8 4457.0 4497.5 4553.1 4554.6 4568.0 4163.7 4193.2 4202.9 4224.7 4244.5 3901.6 4258.9 4312.9 4334.5 4378.7 4109.7 4197.4 4200.2 4271.1 4290.0 4154.7 4203.6 4208.3 4209.5 4211.8 4188.2 4196.6 4197.9 4198.7 4203.7 4587.3 4591.6 4595.1 4619.4 4650.1 4898.5 4901.9 4904.8 4905.1 4949.9 4727.6 4771.6 4912.9 4939.3 4992.7 4522.4 4552.3 4580.6 4600.3 4646.1 5029.1 5033.2 5036.0 5039.4 5086.0 4782.1 4802.9 4813.4 4847.6 4887.3 4716.1 4731.6 4748.7 4765.8 4768.5 4695.1 4715.3 4720.1 4749.5 4764.9 4697.6 4699.6 4700.5 4739.5 4741.6 4014.3 4031.1 4031.8 4100.7 4103.2 3587.1 3633.7 3637.4 3639.5 3682.9 4176.3 4182.4 4183.3 4214.0 4217.5 4660.3 4876.9 4894.4 4899.6 4930.3 4021.0 4070.4 4176.7 4189.3 4218.6 4428.5 4444.3 4461.2 4487.5 4493.6 4592.9 4599.6 4607.2 4608.9 4652.4 4696.6 4701.3 4743.7 4924.6 4945.0 4453.2 4469.2 4502.8 4512.6 4555.7 4759.4 4760.9 4761.0 4761.5 4813.1 4725.5 4820.0 4825.0 4832.5 4872.6 4623.7 4686.5 4705.9 4714.4 4718.9 4735.9 4737.0 4741.1 4757.3 4780.9 4664.4 4674.3 4689.2 4711.9 4749.7 4616.9 4679.3 4691.9 4722.2 4768.8 4712.8 4731.7 4751.5 4764.8 4767.2 01:51:16 INFO - PROCESS | 4712 | 01:51:16 INFO - PROCESS | 4712 | [#1] ext.html Cycles:180 Average:39418.85 Median:17795.76 stddev:72877.37 (409.5%) stddev-sans-first:73023.42 01:51:16 INFO - PROCESS | 4712 | Values: 565.8 570.6 574.1 576.0 589.5 22109.4 27326.0 28139.6 28172.2 30522.7 28485.1 28765.3 28802.0 28813.6 28836.3 5364.1 5501.6 5502.3 5505.1 5506.5 4773.1 4916.2 5473.3 5599.9 5631.9 5625.7 5640.9 5652.3 5652.6 5665.3 5575.3 5599.9 5615.4 5620.1 5637.1 5515.3 5548.4 5558.4 5569.9 5570.3 26238.5 26372.0 26531.6 26550.0 26550.6 2866.4 3033.6 3178.5 3258.2 3490.9 17849.9 17966.2 18115.5 18575.2 18629.6 2721.9 2768.5 2779.2 2779.8 2846.2 170261.0 170868.0 171099.0 171298.1 233341.0 31065.0 51022.2 51349.7 51352.2 51412.5 31329.2 33135.2 33233.2 33239.8 33279.7 11984.3 12141.2 12149.3 12161.1 12164.3 8192.3 9361.0 9388.0 9438.3 9442.9 7024.0 7595.8 7810.7 7818.3 7896.2 3032.9 3041.6 3059.6 3076.2 3085.5 822.8 847.5 864.7 912.0 977.4 26680.0 27846.0 28276.0 28341.3 28635.1 921.6 949.5 1038.5 1041.4 1046.7 14287.9 14763.4 14875.6 15036.9 15205.9 345180.0 348484.0 349511.0 349604.0 349994.0 44609.8 45406.0 45431.0 45447.0 45515.3 1066.2 1086.3 1107.1 1130.8 1139.2 23570.4 26851.0 27459.6 27747.4 28155.2 40731.4 41115.2 41249.4 41261.0 41279.4 265863.0 267866.0 267929.0 268593.0 268916.0 23356.8 23433.1 24308.0 24334.4 25065.4 37080.4 37580.8 37854.4 37908.4 39253.4 31794.7 32823.7 33141.3 33258.0 33788.8 32322.7 32333.4 32648.3 33160.0 33556.2 32726.7 32882.0 32928.7 32967.7 33344.5 25851.4 27016.6 29683.3 30075.4 30160.8 23721.3 24187.6 24188.3 24444.9 24623.3 01:51:16 INFO - PROCESS | 4712 | 01:51:16 INFO - PROCESS | 4712 | [#2] jquery.html Cycles:180 Average:21681.51 Median:4015.44 stddev:59276.71 (1476.2%) stddev-sans-first:59421.34 01:51:16 INFO - PROCESS | 4712 | Values: 339.7 352.9 357.6 366.8 382.6 9675.3 11349.3 11461.9 11814.4 12626.3 13948.2 14131.6 14178.4 14195.2 15478.0 3901.2 4166.0 4167.1 4171.0 4181.5 3600.7 3799.8 3833.8 4111.1 4122.8 3864.2 3866.4 3871.7 3873.8 3874.8 3861.3 3873.3 3875.7 3877.9 3879.7 3316.2 3561.5 3585.2 3621.9 3624.5 9926.8 10057.8 10125.9 10128.5 10130.4 1695.4 1745.5 1799.5 1802.8 1865.4 7450.2 7846.7 7911.3 8078.5 8323.4 1308.6 1389.1 1414.6 1420.4 1432.4 56529.0 57314.7 61905.7 62196.4 66284.3 9058.3 9133.9 9859.1 9987.6 10131.9 11013.1 12102.6 12684.9 13530.3 13712.7 6753.9 6795.5 6941.0 6954.4 7151.9 6547.6 6601.6 6770.1 6791.7 6819.2 3809.9 3908.0 3992.2 4038.6 4055.2 1728.9 1789.6 1822.6 1824.1 1831.4 807.0 809.0 822.9 845.9 864.9 15572.3 16220.2 16843.5 16951.8 17254.6 801.4 813.8 824.2 833.3 846.8 8862.4 9144.1 9151.1 9468.9 9670.6 352851.0 353843.0 357453.0 364231.9 368304.0 45590.3 52526.0 70310.0 77917.0 78482.2 861.2 889.8 890.5 891.1 894.2 14824.9 14839.9 14929.6 15026.5 15483.7 22652.7 32560.5 34308.8 36316.3 36330.3 45407.3 46017.0 46362.8 48325.5 49265.8 6895.8 6950.9 7048.7 7151.3 7359.9 10125.9 11732.3 11763.5 11845.3 11934.3 9442.5 9521.0 9731.2 10009.2 10034.8 8695.1 8817.2 8868.3 10556.9 10557.8 9695.9 9743.2 9744.5 9846.8 9900.7 6735.5 6784.7 7058.9 7068.2 7203.8 9111.4 9640.5 9744.0 9953.6 10037.3 01:51:16 INFO - PROCESS | 4712 | 01:51:16 INFO - PROCESS | 4712 | [#3] mootools.html Cycles:180 Average:4305.76 Median:4611.56 stddev:2324.98 (50.4%) stddev-sans-first:2320.58 01:51:16 INFO - PROCESS | 4712 | Values: 1306.4 1359.6 1404.5 1563.5 1648.0 5932.9 6289.3 6295.6 6300.9 6307.7 5412.2 5556.3 5935.3 6161.0 6226.2 1716.9 1749.6 1753.6 1756.6 1757.5 1761.7 1766.2 1768.4 1771.6 1819.7 1513.9 1543.8 1699.2 1712.2 1725.7 1635.6 1647.2 1647.6 1648.6 1650.3 1666.6 1676.1 1682.0 1696.6 1698.8 6117.4 6156.5 6191.9 6192.9 6196.5 4044.9 4167.1 4176.2 4178.9 4181.3 2512.5 2710.9 2727.9 2766.6 2783.7 768.3 816.5 821.2 833.2 846.0 8423.5 8451.8 8466.7 8475.5 8483.3 3499.7 3701.8 3857.3 3867.3 3876.5 7365.9 7375.3 7380.2 7381.9 7397.0 4192.0 4194.3 4198.1 4201.2 4202.7 3720.9 3828.9 3857.1 3861.2 3861.9 3227.4 3263.5 3338.2 3362.1 3366.1 1077.6 1100.9 1107.6 1108.2 1118.4 678.2 697.3 729.5 751.6 759.3 4337.5 4375.4 4422.5 4429.3 4548.9 401.3 402.8 403.7 406.1 412.3 3003.3 3072.5 3112.2 3145.5 3159.0 7294.0 7872.1 7933.3 7941.2 7944.5 7896.2 7901.1 7905.6 7907.8 7914.0 5978.9 6164.5 6197.2 6215.6 6235.4 4581.7 4641.4 4656.9 4685.7 4786.5 7254.9 7343.5 7389.4 7400.3 7411.6 6884.4 7145.5 7392.3 7393.7 7399.9 5748.1 5867.6 5873.2 5873.8 5876.9 6299.1 6353.8 6374.8 6376.2 6379.9 5735.9 5779.6 5801.2 5869.6 5898.6 5707.3 5718.3 5727.3 5729.5 5873.9 5232.6 5291.7 5307.4 5310.5 5320.5 4144.3 4176.2 4196.2 4286.7 4344.7 3884.1 3974.0 4034.8 4068.7 4135.2 01:51:16 INFO - PROCESS | 4712 | 01:51:16 INFO - PROCESS | 4712 | [#4] prototype.html Cycles:180 Average:4101.97 Median:4626.76 stddev:1209.65 (26.1%) stddev-sans-first:1178.52 01:51:16 INFO - PROCESS | 4712 | Values: 279.0 287.1 289.8 292.1 296.0 4769.2 4780.0 4781.9 4814.6 4820.9 4764.4 4767.5 4768.7 4772.5 4778.0 3510.2 3619.9 3627.3 3725.8 3727.8 3698.6 3717.7 3724.6 3726.3 3732.1 3681.8 3682.2 3683.4 3694.8 3704.3 3515.2 3556.5 3628.7 3698.7 3706.5 3233.7 3236.2 3243.6 3245.8 3250.8 4582.3 4596.7 4602.9 4603.5 4622.3 4144.3 4181.7 4210.5 4221.7 4227.5 4672.4 4888.8 4923.3 4938.0 4948.7 3456.0 3458.7 3469.9 3485.5 3490.5 5113.8 5173.7 5214.4 5221.7 5232.7 3448.9 3527.3 3548.3 3552.4 3561.1 3598.6 3598.8 3598.9 3606.5 3606.9 4148.6 4160.0 4161.5 4181.1 4184.3 4897.5 4989.3 5004.2 5010.9 5027.1 1212.2 1220.3 1225.2 1227.7 1228.5 793.7 832.3 840.5 842.2 847.1 4145.5 4176.2 4233.3 4240.7 4305.6 4983.4 5097.2 5105.9 5126.9 5136.6 4356.4 4357.4 4365.7 4367.3 4385.1 2511.8 2611.8 2614.6 2629.8 2641.7 4592.2 4605.4 4609.3 4614.2 4635.9 5044.9 5074.5 5084.3 5090.3 5109.6 4463.8 4618.5 4631.2 4652.8 4779.6 5123.8 5141.2 5148.3 5152.7 5204.2 5051.9 5057.9 5061.8 5067.7 5077.0 4640.5 4746.4 4780.1 4805.8 4865.1 3571.4 3571.8 3601.1 3609.3 3611.9 5167.0 5174.4 5204.2 5205.4 5217.5 4767.5 5017.3 5051.2 5074.2 5097.8 5020.5 5022.3 5024.7 5027.9 5039.6 4953.7 4965.4 4966.0 4977.7 5005.4 4944.8 5013.7 5036.3 5087.1 5113.6 4700.5 4752.2 4811.5 4899.7 4928.8 01:51:16 INFO - PROCESS | 4712 | 01:51:16 INFO - PROCESS | 4712 | [#5] yui.html Cycles:180 Average:12851.77 Median:27829.28 stddev:16621.28 (59.7%) stddev-sans-first:16642.59 01:51:16 INFO - PROCESS | 4712 | Values: 634.7 651.9 658.2 659.0 715.8 10301.4 11137.8 11758.9 11775.1 11783.3 10938.5 11376.3 11394.1 11399.6 11405.1 607.7 721.8 750.6 760.7 761.2 626.0 736.3 756.5 768.4 770.0 804.9 807.6 811.7 812.2 812.5 644.9 804.1 804.6 805.2 805.3 485.1 566.2 583.2 588.6 593.2 10488.0 10510.1 10536.8 10543.6 10550.4 8674.4 8895.6 9119.0 9140.8 9416.6 8094.4 8106.8 8161.8 8294.1 8332.1 2455.8 2503.2 2509.7 2518.1 2526.3 47232.3 48774.5 49022.0 50304.0 50576.2 7151.6 7173.9 7190.6 7209.7 7231.0 13778.4 13834.4 13851.7 13856.7 13901.9 6068.1 6085.4 6427.1 6678.6 6726.0 3661.9 3676.0 3719.5 3761.9 3844.3 2732.2 2819.8 2832.2 2836.2 2846.0 488.3 490.4 491.9 498.9 504.3 462.6 507.6 528.5 547.8 556.8 6726.4 7039.0 7188.8 7360.5 7405.1 442.9 487.1 576.7 580.8 586.5 3350.2 3507.6 3557.2 3608.4 3714.6 53653.0 55402.4 56091.4 74307.0 76784.0 50665.2 52838.7 54521.7 55110.7 56412.4 43989.1 44396.0 44402.6 44892.8 45010.8 7109.5 7377.2 7608.2 7680.0 7829.2 26926.9 27990.7 29003.9 34878.0 37151.3 36070.5 41252.2 42666.8 46259.8 46688.5 10028.6 10031.3 10309.9 10419.2 10747.9 10276.1 10510.9 10689.5 10779.5 11235.3 9386.2 9413.5 9567.9 9672.1 9795.9 10064.7 10125.5 10290.4 10434.2 10491.9 8989.2 9108.6 9187.5 9496.0 9710.2 8024.7 8082.8 8168.9 8318.2 8645.7 7830.5 8662.8 8796.9 8981.5 9105.1 01:51:16 INFO - PROCESS | 4712 | -------- Summary: end -------- 01:51:16 INFO - PROCESS | 4712 | 01:51:17 INFO - TEST-INFO | 4712: exit 0 01:51:17 INFO - TEST-OK | dromaeo_css | took 1121506ms 01:51:17 INFO - TEST-START | kraken 01:51:17 INFO - operating with platform_type : linux_ 01:51:17 INFO - Initialising browser for kraken test... 01:51:17 INFO - TEST-INFO | started process 5014 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT8rASW/profile http://localhost:38893/getInfo.html) 01:51:21 INFO - PROCESS | 5014 | __metrics Screen width/height:1600/1200 01:51:21 INFO - PROCESS | 5014 | colorDepth:24 01:51:21 INFO - PROCESS | 5014 | Browser inner width/height: 1024/697 01:51:21 INFO - PROCESS | 5014 | __metrics 01:51:22 INFO - PROCESS | 5014 | 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" 01:51:22 INFO - PROCESS | 5014 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:51:22 INFO - PROCESS | 5014 | console.error: PushService: 01:51:22 INFO - PROCESS | 5014 | stateChangeProcessEnqueue: Error transitioning state 01:51:22 INFO - PROCESS | 5014 | UnknownError 01:51:23 INFO - TEST-INFO | 5014: exit 0 01:51:23 INFO - Browser initialized. 01:51:23 INFO - Running cycle 1/1 for kraken test... 01:51:23 INFO - TEST-INFO | started process 5098 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT8rASW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:51:35 INFO - PROCESS | 5098 | RSS: Main: 175104000 01:51:35 INFO - PROCESS | 5098 | 01:51:38 INFO - PROCESS | 5098 | Cycle 1(1): loaded http://localhost:38893/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38893/tests/kraken/driver.html?testName=audio-beat-detection) 01:51:39 INFO - PROCESS | 5098 | RSS: Main: 231505920 01:51:39 INFO - PROCESS | 5098 | 01:51:42 INFO - PROCESS | 5098 | Cycle 1(1): loaded http://localhost:38893/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38893/tests/kraken/driver.html?testName=audio-dft) 01:51:43 INFO - PROCESS | 5098 | RSS: Main: 218681344 01:51:43 INFO - PROCESS | 5098 | 01:51:46 INFO - PROCESS | 5098 | Cycle 1(1): loaded http://localhost:38893/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38893/tests/kraken/driver.html?testName=audio-fft) 01:51:46 INFO - PROCESS | 5098 | RSS: Main: 300584960 01:51:46 INFO - PROCESS | 5098 | 01:51:49 INFO - PROCESS | 5098 | Cycle 1(1): loaded http://localhost:38893/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38893/tests/kraken/driver.html?testName=audio-oscillator) 01:51:49 INFO - PROCESS | 5098 | RSS: Main: 211648512 01:51:49 INFO - PROCESS | 5098 | 01:51:52 INFO - PROCESS | 5098 | Cycle 1(1): loaded http://localhost:38893/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38893/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:51:52 INFO - PROCESS | 5098 | RSS: Main: 213946368 01:51:52 INFO - PROCESS | 5098 | 01:51:55 INFO - PROCESS | 5098 | Cycle 1(1): loaded http://localhost:38893/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38893/tests/kraken/driver.html?testName=imaging-darkroom) 01:51:56 INFO - PROCESS | 5098 | RSS: Main: 253894656 01:51:56 INFO - PROCESS | 5098 | 01:51:59 INFO - PROCESS | 5098 | Cycle 1(1): loaded http://localhost:38893/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38893/tests/kraken/driver.html?testName=imaging-desaturate) 01:52:00 INFO - PROCESS | 5098 | RSS: Main: 253358080 01:52:00 INFO - PROCESS | 5098 | 01:52:03 INFO - PROCESS | 5098 | Cycle 1(1): loaded http://localhost:38893/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38893/tests/kraken/driver.html?testName=json-parse-financial) 01:52:03 INFO - PROCESS | 5098 | RSS: Main: 252628992 01:52:03 INFO - PROCESS | 5098 | 01:52:05 INFO - PROCESS | 5098 | Cycle 1(1): loaded http://localhost:38893/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38893/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:52:06 INFO - PROCESS | 5098 | RSS: Main: 214384640 01:52:06 INFO - PROCESS | 5098 | 01:52:08 INFO - PROCESS | 5098 | Cycle 1(1): loaded http://localhost:38893/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38893/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:52:08 INFO - PROCESS | 5098 | RSS: Main: 222474240 01:52:08 INFO - PROCESS | 5098 | 01:52:10 INFO - PROCESS | 5098 | Cycle 1(1): loaded http://localhost:38893/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38893/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:52:11 INFO - PROCESS | 5098 | RSS: Main: 230600704 01:52:11 INFO - PROCESS | 5098 | 01:52:14 INFO - PROCESS | 5098 | Cycle 1(1): loaded http://localhost:38893/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38893/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:52:15 INFO - PROCESS | 5098 | RSS: Main: 234536960 01:52:15 INFO - PROCESS | 5098 | 01:52:18 INFO - PROCESS | 5098 | Cycle 1(1): loaded http://localhost:38893/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38893/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:52:18 INFO - PROCESS | 5098 | RSS: Main: 235769856 01:52:18 INFO - PROCESS | 5098 | 01:52:20 INFO - PROCESS | 5098 | Cycle 1(1): loaded http://localhost:38893/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38893/tests/kraken/driver.html?testName=ai-astar) 01:52:20 INFO - PROCESS | 5098 | RSS: Main: 285978624 01:52:20 INFO - PROCESS | 5098 | 01:52:20 INFO - PROCESS | 5098 | __start_tp_report 01:52:20 INFO - PROCESS | 5098 | _x_x_mozilla_page_load 01:52:20 INFO - PROCESS | 5098 | _x_x_mozilla_page_load_details 01:52:20 INFO - PROCESS | 5098 | |i|pagename|runs| 01:52:20 INFO - PROCESS | 5098 | |0;ai-astar;108;116;116;116;117;116;117;117;115;117 01:52:20 INFO - PROCESS | 5098 | |1;audio-beat-detection;158;130;133;172;134;127;129;128;161;128 01:52:20 INFO - PROCESS | 5098 | |2;audio-dft;160;170;161;161;161;161;161;160;161;162 01:52:20 INFO - PROCESS | 5098 | |3;audio-fft;75;76;76;109;77;77;76;76;98;76 01:52:20 INFO - PROCESS | 5098 | |4;audio-oscillator;84;82;118;84;85;85;105;84;85;118 01:52:20 INFO - PROCESS | 5098 | |5;imaging-gaussian-blur;117;118;119;119;117;117;117;117;117;116 01:52:20 INFO - PROCESS | 5098 | |6;imaging-darkroom;146;146;147;148;147;146;147;147;147;146 01:52:20 INFO - PROCESS | 5098 | |7;imaging-desaturate;95;99;95;95;95;96;95;95;96;95 01:52:20 INFO - PROCESS | 5098 | |8;json-parse-financial;63;64;64;65;64;65;64;65;65;64 01:52:20 INFO - PROCESS | 5098 | |9;json-stringify-tinderbox;65;65;65;65;65;67;66;66;66;67 01:52:20 INFO - PROCESS | 5098 | |10;stanford-crypto-aes;94;86;91;84;84;92;83;90;87;83 01:52:20 INFO - PROCESS | 5098 | |11;stanford-crypto-ccm;146;141;143;144;141;141;146;141;235;141 01:52:20 INFO - PROCESS | 5098 | |12;stanford-crypto-pbkdf2;179;179;180;189;183;182;181;178;176;177 01:52:20 INFO - PROCESS | 5098 | |13;stanford-crypto-sha256-iterative;70;70;70;70;74;70;71;70;70;69 01:52:20 INFO - PROCESS | 5098 | __end_tp_report 01:52:20 INFO - PROCESS | 5098 | __start_cc_report 01:52:20 INFO - PROCESS | 5098 | _x_x_mozilla_cycle_collect,2006 01:52:20 INFO - PROCESS | 5098 | __end_cc_report 01:52:20 INFO - PROCESS | 5098 | __startTimestamp1479462740958__endTimestamp 01:52:20 INFO - PROCESS | 5098 | 01:52:20 INFO - PROCESS | 5098 | ------- Summary: start ------- 01:52:20 INFO - PROCESS | 5098 | Number of tests: 14 01:52:20 INFO - PROCESS | 5098 | 01:52:20 INFO - PROCESS | 5098 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.50 stddev:2.72 (2.3%) stddev-sans-first:0.71 01:52:20 INFO - PROCESS | 5098 | Values: 108.0 116.0 116.0 116.0 117.0 116.0 117.0 117.0 115.0 117.0 01:52:20 INFO - PROCESS | 5098 | 01:52:20 INFO - PROCESS | 5098 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:133.50 stddev:16.84 (12.6%) stddev-sans-first:16.55 01:52:20 INFO - PROCESS | 5098 | Values: 158.0 130.0 133.0 172.0 134.0 127.0 129.0 128.0 161.0 128.0 01:52:20 INFO - PROCESS | 5098 | 01:52:20 INFO - PROCESS | 5098 | [#2] audio-dft Cycles:10 Average:161.80 Median:161.00 stddev:2.94 (1.8%) stddev-sans-first:3.04 01:52:20 INFO - PROCESS | 5098 | Values: 160.0 170.0 161.0 161.0 161.0 161.0 161.0 160.0 161.0 162.0 01:52:20 INFO - PROCESS | 5098 | 01:52:20 INFO - PROCESS | 5098 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:11.84 (15.6%) stddev-sans-first:12.32 01:52:20 INFO - PROCESS | 5098 | Values: 75.0 76.0 76.0 109.0 77.0 77.0 76.0 76.0 98.0 76.0 01:52:20 INFO - PROCESS | 5098 | 01:52:20 INFO - PROCESS | 5098 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:84.00 stddev:14.72 (17.5%) stddev-sans-first:15.25 01:52:20 INFO - PROCESS | 5098 | Values: 84.0 82.0 118.0 84.0 85.0 85.0 105.0 84.0 85.0 118.0 01:52:20 INFO - PROCESS | 5098 | 01:52:20 INFO - PROCESS | 5098 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 01:52:20 INFO - PROCESS | 5098 | Values: 117.0 118.0 119.0 119.0 117.0 117.0 117.0 117.0 117.0 116.0 01:52:20 INFO - PROCESS | 5098 | 01:52:20 INFO - PROCESS | 5098 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 01:52:20 INFO - PROCESS | 5098 | Values: 146.0 146.0 147.0 148.0 147.0 146.0 147.0 147.0 147.0 146.0 01:52:20 INFO - PROCESS | 5098 | 01:52:20 INFO - PROCESS | 5098 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.00 stddev:1.26 (1.3%) stddev-sans-first:1.32 01:52:20 INFO - PROCESS | 5098 | Values: 95.0 99.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 01:52:20 INFO - PROCESS | 5098 | 01:52:20 INFO - PROCESS | 5098 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.50 stddev:0.67 (1.0%) stddev-sans-first:0.53 01:52:20 INFO - PROCESS | 5098 | Values: 63.0 64.0 64.0 65.0 64.0 65.0 64.0 65.0 65.0 64.0 01:52:20 INFO - PROCESS | 5098 | 01:52:20 INFO - PROCESS | 5098 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 01:52:20 INFO - PROCESS | 5098 | Values: 65.0 65.0 65.0 65.0 65.0 67.0 66.0 66.0 66.0 67.0 01:52:20 INFO - PROCESS | 5098 | 01:52:20 INFO - PROCESS | 5098 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:88.50 stddev:4.06 (4.6%) stddev-sans-first:3.54 01:52:20 INFO - PROCESS | 5098 | Values: 94.0 86.0 91.0 84.0 84.0 92.0 83.0 90.0 87.0 83.0 01:52:20 INFO - PROCESS | 5098 | 01:52:20 INFO - PROCESS | 5098 | [#11] stanford-crypto-ccm Cycles:10 Average:151.90 Median:143.50 stddev:29.27 (20.4%) stddev-sans-first:30.97 01:52:20 INFO - PROCESS | 5098 | Values: 146.0 141.0 143.0 144.0 141.0 141.0 146.0 141.0 235.0 141.0 01:52:20 INFO - PROCESS | 5098 | 01:52:20 INFO - PROCESS | 5098 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.40 Median:180.50 stddev:3.72 (2.1%) stddev-sans-first:3.91 01:52:20 INFO - PROCESS | 5098 | Values: 179.0 179.0 180.0 189.0 183.0 182.0 181.0 178.0 176.0 177.0 01:52:20 INFO - PROCESS | 5098 | 01:52:20 INFO - PROCESS | 5098 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.00 stddev:1.35 (1.9%) stddev-sans-first:1.42 01:52:20 INFO - PROCESS | 5098 | Values: 70.0 70.0 70.0 70.0 74.0 70.0 71.0 70.0 70.0 69.0 01:52:20 INFO - PROCESS | 5098 | -------- Summary: end -------- 01:52:20 INFO - PROCESS | 5098 | 01:52:22 INFO - TEST-INFO | 5098: exit 0 01:52:22 INFO - TEST-OK | kraken | took 64920ms 01:52:22 INFO - SUITE-END | took 1186s 01:52:22 INFO - Completed test suite (00:19:46) 01:52:22 INFO - javascript benchmark 01:52:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2509.849409035458, 2539.1240022192337, 2562.9359266018355, 2566.5636841736905, 2581.1095172165597, 4352.281873490878, 4419.62433193179, 4517.435320584927, 4539.568740969607, 4565.84019559315, 4456.955430445694, 4497.482789479211, 4553.112143132091, 4554.567316104964, 4567.977160114203, 4163.708540402173, 4193.2242535130945, 4202.852900148496, 4224.704270701052, 4244.469441319835, 3901.55132159801, 4258.850940217093, 4312.913741725163, 4334.5448727883595, 4378.6715996300245, 4109.6506796922295, 4197.433346498215, 4200.15996800638, 4271.103068355634, 4290.013296941705, 4154.709170358076, 4203.62167404935, 4208.284591619401, 4209.515905670856, 4211.789410529492, 4188.225178342016, 4196.601322874352, 4197.874063778091, 4198.6641068714425, 4203.684723645708, 4587.311903214511, 4591.586757191835, 4595.103954728829, 4619.3994780678295, 4650.116477869194, 4898.485659005789, 4901.901961960776, 4904.779284932151, 4905.092557876768, 4949.876253093666, 4727.621790256771, 4771.570558649738, 4912.877178070541, 4939.283803848458, 4992.725400102993, 4522.3668686383935, 4552.317152427129, 4580.610648094949, 4600.2869555218995, 4646.070785842845, 5029.119904016782, 5033.245013248042, 5035.974820125949, 5039.44566097729, 5086.033653605803, 4782.115308667908, 4802.9452771864535, 4813.374261346073, 4847.636427267898, 4887.340209071801, 4716.056788642285, 4731.597814185833, 4748.715077095385, 4765.785539650724, 4768.47546769855, 4695.131400690883, 4715.269133284346, 4720.12677654635, 4749.453812811502, 4764.904701905943, 4697.647676424282, 4699.553542413465, 4700.482946875841, 4739.526047395233, 4741.620670346364, 4014.3175660137845, 4031.1333063390925, 4031.778252196157, 4100.7334523255895, 4103.158852435244, 3587.121155316964, 3633.7274704397278, 3637.399829028234, 3639.490471334015, 3682.8526858925343, 4176.331786914079, 4182.414461975326, 4183.330667093251, 4214.0, 4217.493900731932, 4660.347551342815, 4876.853694389174, 4894.412670479565, 4899.58353539946, 4930.309756634074, 4020.9597904020584, 4070.430139780433, 4176.686748493875, 4189.287821070426, 4218.620324170839, 4428.512863585003, 4444.266695995189, 4461.219286624828, 4487.461504619401, 4493.550644935481, 4592.862214133581, 4599.586037256663, 4607.193741095228, 4608.861734147981, 4652.3719297895705, 4696.553827386393, 4701.294805779161, 4743.715377077387, 4924.63065270099, 4945.0, 4453.176162409835, 4469.150861336336, 4502.752348620857, 4512.593866552026, 4555.658325625657, 4759.357486739246, 4760.928586071281, 4761.0, 4761.452432970253, 4813.109574728686, 4725.527447255247, 4819.95180048195, 4825.0, 4832.540908613676, 4872.585830204331, 4623.745693986863, 4686.484486706528, 4705.858824235278, 4714.38712967312, 4718.8584342469785, 4735.928961065656, 4736.976315118402, 4741.099191153669, 4757.3101900224965, 4780.856574302777, 4664.416947881515, 4674.275487299474, 4689.179393606173, 4711.905761884812, 4749.715017098985, 4616.907661846812, 4679.27471241958, 4691.859244222543, 4722.1972264714395, 4768.809247630056, 4712.81148754046, 4731.716097034189, 4751.477337492942, 4764.785584648768, 4767.165745994506], "value": 4457.690976109634, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.8443927919822, 570.60913274407, 574.112995422073, 576.0322657934668, 589.5254320272181, 22109.447263818412, 27326.0, 28139.577906331397, 28172.154835354922, 30522.694773052262, 28485.145445636663, 28765.280867978312, 28801.991930282446, 28813.56779648307, 28836.279093022633, 5364.061289274381, 5501.559875209973, 5502.257195278627, 5505.091659876116, 5506.531944784698, 4773.06925149596, 4916.164252077156, 5473.261109750192, 5599.944000560004, 5631.887362252753, 5625.718714064301, 5640.858978525549, 5652.321721393439, 5652.576056795736, 5665.263515742969, 5575.275214222145, 5599.916001259984, 5615.354234263071, 5620.100783874561, 5637.069883469223, 5515.255440515519, 5548.44515548446, 5558.388577256498, 5569.944300556983, 5570.303712035996, 26238.475230495475, 26372.0, 26531.602025969627, 26550.0, 26550.6017409739, 2866.3550701092295, 3033.605631267943, 3178.523221516791, 3258.1691668624585, 3490.89527314181, 17849.910750446295, 17966.19152138144, 18115.456536303933, 18575.164117614604, 18629.62740745191, 2721.931951701223, 2768.4739899419046, 2779.1523585306472, 2779.81931174473, 2846.188836181699, 170261.0, 170868.0, 171099.0, 171298.14350928165, 233341.0, 31065.0, 51022.234666480035, 51349.74325128425, 51352.229716554284, 51412.485875141516, 31329.216769580944, 33135.171620709196, 33233.16917077044, 33239.83380083084, 33279.66720332814, 11984.340861252715, 12141.210821296587, 12149.331786751813, 12161.087918406154, 12164.330961797186, 8192.34461243099, 9361.017093205252, 9388.0, 9438.292128090421, 9442.90557094434, 7023.964880175567, 7595.772126836204, 7810.687572497037, 7818.296353328228, 7896.170902055316, 3032.86352114151, 3041.5893854329383, 3059.602251707264, 3076.200187951149, 3085.460044492205, 822.8066404394963, 847.4660963592897, 864.6671031652859, 911.9863202051974, 977.3647129365969, 26680.0, 27846.0, 28276.0, 28341.282564135716, 28635.14094577166, 921.5530467723149, 949.544218774978, 1038.4548112241134, 1041.44282808697, 1046.706922061824, 14287.85712142886, 14763.409463621334, 14875.628109297355, 15036.924815375853, 15205.923970380078, 345180.0, 348484.0, 349511.0, 349604.0, 349994.0, 44609.77695111569, 45406.0, 45431.0, 45447.0, 45515.31727024097, 1066.1630619963291, 1086.2613422872523, 1107.125370956935, 1130.8416821644976, 1139.2367114033618, 23570.410739731644, 26851.0, 27459.588106178824, 27747.438056170755, 28155.155345339674, 40731.38902916399, 41115.1776964465, 41249.381259281734, 41261.0, 41279.380809287286, 265863.0, 267866.0, 267929.0, 268593.0, 268916.0, 23356.76643233546, 23433.06267749339, 24308.0, 24334.391640209138, 25065.373365666004, 37080.44379334258, 37580.81209593934, 37854.43218351782, 37908.43137352887, 39253.41119883261, 31794.68205317917, 32823.74820028784, 33141.337173256885, 33258.0, 33788.83105584457, 32322.676773232906, 32333.35333293368, 32648.34703305968, 33160.0, 33556.1610959728, 32726.672733272364, 32882.0, 32928.67071329256, 32967.67032329646, 33344.49983250302, 25851.353716156493, 27016.594751078355, 29683.257918552208, 30075.398492030476, 30160.84919575388, 23721.288361349187, 24187.63718544188, 24188.274351769476, 24444.877775611007, 24623.261302160965], "value": 14203.716093595942, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.6938770427708, 352.88354842901845, 357.64771699875627, 366.8404244153794, 382.56960918966143, 9675.27435442342, 11349.319040857545, 11461.942690286536, 11814.350210738417, 12626.30555319457, 13948.163110213394, 14131.576052718408, 14178.361973711182, 14195.219262940534, 15478.0, 3901.1807520420743, 4166.020985068507, 4167.124903770212, 4170.97914510427, 4181.477315335583, 3600.6579374959338, 3799.7910114943666, 3833.7891415972113, 4111.075008123178, 4122.773247471388, 3864.2271545690833, 3866.4007078902814, 3871.748336358142, 3873.8256778444897, 3874.8256328465286, 3861.3435715928217, 3873.302805495038, 3875.7093218008763, 3877.922441551153, 3879.7478163919254, 3316.1543806329473, 3561.5013898054294, 3585.175409655768, 3621.94567081494, 3624.5106910567, 9926.751831204205, 10057.798844023151, 10125.949370253174, 10128.493575321278, 10130.392176469435, 1695.355764809377, 1745.4589077386051, 1799.5321216483808, 1802.7836659600932, 1865.3844231403605, 7450.18048014718, 7846.7052936265445, 7911.28798408146, 8078.474899131537, 8323.375746819012, 1308.5616318533303, 1389.1179101270766, 1414.5897689669982, 1420.3821337718125, 1432.3554400519704, 56529.0, 57314.713426433016, 61905.6904715478, 62196.37803621951, 66284.33715662878, 9058.32062595308, 9133.862992055125, 9859.112679858847, 9987.600495980225, 10131.93614670449, 11013.118950483942, 12102.576409825613, 12684.87315126837, 13530.323483825769, 13712.725745485035, 6753.898691519631, 6795.490338224653, 6941.0, 6954.374106330454, 7151.89272160918, 6547.607143571401, 6601.603903765789, 6770.086038384854, 6791.728330866808, 6819.215790184093, 3809.9047523811573, 3908.0, 3992.2414741199077, 4038.6365227129113, 4055.229506393776, 1728.8616910647117, 1789.5526118470382, 1822.6354729054242, 1824.1153040775214, 1831.3773317071993, 806.9636866341028, 809.0372456776535, 822.9053658829191, 845.923258400625, 864.8745931839974, 15572.299246533707, 16220.188990550425, 16843.494695159166, 16951.830481695273, 17254.568635783955, 801.4269797095105, 813.7924829168525, 824.2046425199711, 833.2792134803351, 846.7840700621302, 8862.379633425599, 9144.131307525775, 9151.130642588943, 9468.90531094694, 9670.613175473043, 352851.0, 353843.0, 357453.0, 364231.86898882204, 368304.0, 45590.31614525785, 52526.0, 70310.0, 77917.0, 78482.21517784863, 861.1947828780111, 889.768660148366, 890.4879694175875, 891.0777345447431, 894.1639567004871, 14824.851751482347, 14839.92580037093, 14929.626759331104, 15026.549203523911, 15483.690326193639, 22652.660210096532, 32560.51159232661, 34308.82845585756, 36316.27367452583, 36330.27339453249, 45407.318890217335, 46017.0, 46362.7681861602, 48325.5167448321, 49265.75367123142, 6895.793126206222, 6950.93049069523, 7048.682809273492, 7151.320624540868, 7359.926400735924, 10125.949370253396, 11732.296062236293, 11763.47064382122, 11845.348505832262, 11934.28394296345, 9442.52787360643, 9520.952395238257, 9731.172850307803, 10009.249306302203, 10034.849477257701, 8695.130486951255, 8817.16236957488, 8868.290536757173, 10556.947215264181, 10557.788844223227, 9695.9030409695, 9743.171830394496, 9744.464054476788, 9846.753831154278, 9900.733535321171, 6735.49483788708, 6784.660766961731, 7058.929410705828, 7068.187158476635, 7203.783886483414, 9111.362204645611, 9640.517974101127, 9744.0, 9953.601855925972, 10037.34757240777], "value": 7162.414758615379, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.3598836570077, 1359.5921223632909, 1404.480342273359, 1563.53875606696, 1648.0358989990855, 5932.881342373155, 6289.276733175686, 6295.559310848237, 6300.905486417708, 6307.747690092397, 5412.188171774226, 5556.333240011194, 5935.317438494574, 6161.045038019103, 6226.190595222614, 1716.9313227470918, 1749.597592553707, 1753.6142048749255, 1756.6223261998668, 1757.4639734880857, 1761.7005109131478, 1766.2052076565597, 1768.3722278591108, 1771.6191018930926, 1819.672458957387, 1513.8940274180757, 1543.7838702581648, 1699.1928833803968, 1712.1524845201643, 1725.6721222967658, 1635.5502236884834, 1647.2093395170266, 1647.6128109894166, 1648.5960939569882, 1650.2656317938522, 1666.5500314915025, 1676.0865328396053, 1682.0328311221097, 1696.575856035991, 1698.8046374666949, 6117.418845209698, 6156.4766994805495, 6191.876162476725, 6192.9380706192815, 6196.504279657616, 4044.858429954967, 4167.1457351242925, 4176.18564379946, 4178.91642167155, 4181.289180839264, 2512.484940587175, 2710.864456777173, 2727.9045233416737, 2766.6265054217824, 2783.74946254836, 768.3123604374053, 816.4529765057425, 821.2075347289893, 833.2167762303476, 845.9873101903477, 8423.452475589067, 8451.83096338076, 8466.74599762008, 8475.533845638487, 8483.321334293303, 3499.650034996531, 3701.796401197906, 3857.3056849767313, 3867.2845523577666, 3876.496055512822, 7365.926340736632, 7375.336219740249, 7380.188179300273, 7381.852362952711, 7397.038385009914, 4191.958080419156, 4194.2869712149, 4198.118395137056, 4201.180769749931, 4202.684798640114, 3720.8697695580527, 3828.9234215315537, 3857.0935830079907, 3861.2470568239487, 3861.9034524137123, 3227.3545290941906, 3263.461528847761, 3338.198832280284, 3362.0586235854, 3366.074329559342, 1077.6228320087907, 1100.8533359948133, 1107.5791199344358, 1108.2020944919645, 1118.3904771899333, 678.220046946016, 697.3375293471223, 729.4930023633524, 751.6241879060469, 759.3128218961848, 4337.522872484024, 4375.387445757597, 4422.513523512411, 4429.269170586882, 4548.931766023512, 401.33979603552575, 402.82477122451826, 403.7436227995244, 406.06604808939323, 412.3196725403049, 3003.339265361617, 3072.4776787946103, 3112.2375018120706, 3145.543896135048, 3158.98420507896, 7293.9635301823155, 7872.094709108525, 7933.325667318227, 7941.166177551389, 7944.523328600187, 7896.170902055316, 7901.091374491892, 7905.644246008944, 7907.802304942307, 7914.0, 5978.910316345258, 6164.537659675542, 6197.225346831736, 6215.564910456315, 6235.407636274546, 4581.702189357681, 4641.419822522184, 4656.883577910444, 4685.718856868599, 4786.521347865186, 7254.89117663246, 7343.522671026366, 7389.408847292097, 7400.333969942731, 7411.62941852916, 6884.4148247397525, 7145.4998150128995, 7392.260773922565, 7393.741219057307, 7399.889001664872, 5748.137779333133, 5867.618604790675, 5873.236479257669, 5873.765049398147, 5876.882462350814, 6299.149614802126, 6353.809385718436, 6374.808755737336, 6376.234851817811, 6379.904301435389, 5735.8566035849435, 5779.566532510163, 5801.1878337032, 5869.647821130746, 5898.557608179318, 5707.258056452634, 5718.256626638677, 5727.341355744143, 5729.455701708331, 5873.94126058751, 5232.581393488588, 5291.735413229246, 5307.4427185145005, 5310.522053015247, 5320.494553017457, 4144.33690609501, 4176.206520761046, 4196.244675958357, 4286.742795432284, 4344.695871288979, 3884.1066554693143, 3973.980130099447, 4034.7780872052317, 4068.6541643960595, 4135.214309281227], "value": 3457.507502111182, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.9832610043397, 287.09564870657425, 289.78121518253715, 292.07849235661496, 295.98816047358105, 4769.23692209247, 4780.0, 4781.90436191276, 4814.566688997989, 4820.903581928359, 4764.356811830402, 4767.499412561674, 4768.666193366465, 4772.451168115667, 4777.9761101194445, 3510.192655689193, 3619.932120024586, 3627.292677927805, 3725.8323375448035, 3727.7763334199967, 3698.6369763842404, 3717.7397582169124, 3724.5530536335677, 3726.329260733067, 3732.104294969215, 3681.785010946395, 3682.2451397463456, 3683.4474828775765, 3694.7598406103652, 3704.259148170363, 3515.244222492151, 3556.484309775094, 3628.727845411605, 3698.7041036716996, 3706.4996225509617, 3233.676632336771, 3236.1909522619344, 3243.6269828969735, 3245.815277423747, 3250.837458127084, 4582.335561343587, 4596.724196548184, 4602.884927876797, 4603.470600880908, 4622.2835460503675, 4144.342263094786, 4181.749095054306, 4210.473690788652, 4221.704480686353, 4227.450431443924, 4672.3692301539195, 4888.755562221911, 4923.286123512106, 4938.0, 4948.678335908155, 3455.9654403456148, 3458.706009989154, 3469.8612055517747, 3485.4946032825096, 3490.4764285357146, 5113.795448182068, 5173.715445650488, 5214.40960507049, 5221.686698798047, 5232.686038837682, 3448.9482657760154, 3527.3298073365977, 3548.2548664780684, 3552.3960926642535, 3561.0919215600375, 3598.5501812273465, 3598.838052287653, 3598.9100272492874, 3606.4770608261656, 3606.945895811565, 4148.62662360389, 4159.9792001040405, 4161.479815023122, 4181.121964387513, 4184.28867092595, 4897.534734200245, 4989.301497790312, 5004.249362595567, 5010.8703800885205, 5027.145385284511, 1212.1575505023923, 1220.3288191494642, 1225.2036176485178, 1227.7360367520848, 1228.4594778297699, 793.7182300283316, 832.3050253038781, 840.4873027453249, 842.1536355962219, 847.1359213602092, 4145.471262529854, 4176.18564379943, 4233.280342341809, 4240.734634331548, 4305.590968858016, 4983.426905905795, 5097.235414687826, 5105.948940510547, 5126.948730512721, 5136.563392111638, 4356.3683265926265, 4357.368181613711, 4365.650747940157, 4367.323064924942, 4385.101054283864, 2511.8116141289474, 2611.843289402642, 2614.6208799724313, 2629.8027647926483, 2641.656584643984, 4592.196365636, 4605.355250264965, 4609.294561012447, 4614.238650622677, 4635.8841028973875, 5044.899102017939, 5074.549306471635, 5084.33903592538, 5090.338256026767, 5109.616778741535, 4463.754493502824, 4618.475902952017, 4631.235846085426, 4652.837150699709, 4779.593734532465, 5123.820666276662, 5141.203113517261, 5148.253503242084, 5152.742362881916, 5204.1673332266655, 5051.87370315745, 5057.949420505748, 5061.772220250024, 5067.69593824357, 5077.0, 4640.535946405333, 4746.359241502491, 4780.11567859947, 4805.783739731791, 4865.1242776300605, 3571.428571428559, 3571.8392672329287, 3601.063723431979, 3609.314230296235, 3611.8555257789394, 5166.951498615835, 5174.379074511083, 5204.193350030751, 5205.427402985744, 5217.530422262014, 4767.475577686521, 5017.297578339108, 5051.242313652834, 5074.16276314404, 5097.770600323069, 5020.523050310215, 5022.347094877642, 5024.708815725706, 5027.899442011066, 5039.571636410946, 4953.678010929278, 4965.354503914468, 4965.950340496549, 4977.680914557717, 5005.374328208974, 4944.777485013255, 5013.724245166405, 5036.338008457274, 5087.0735593033705, 5113.590912727047, 4700.45944716362, 4752.239641657457, 4811.518848115161, 4899.706017638953, 4928.753562321798], "value": 3715.098488211083, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.65094198191, 651.8924377477716, 658.2430205263948, 658.9505787065968, 715.7530651925088, 10301.433421161833, 11137.83293250601, 11758.882411175886, 11775.116866235034, 11783.29300241985, 10938.507767150477, 11376.260543064716, 11394.088472922167, 11399.601013964513, 11405.08759299256, 607.6566739792025, 721.8267615772203, 750.5834261984596, 760.6615056299948, 761.2159475739996, 625.9687015649222, 736.282124928196, 756.5044895593395, 768.3852917665873, 770.0028463140247, 804.8832919226709, 807.6365635464035, 811.6753298680545, 812.1999830167281, 812.5165526511717, 644.8613548087137, 804.1315379390273, 804.5896592737687, 805.2470939671397, 805.2832978649008, 485.1461427886909, 566.2016556655137, 583.2243116654839, 588.6409290332894, 593.1962191230863, 10487.951204879528, 10510.10664093553, 10536.789264214749, 10543.630972915911, 10550.366977981346, 8674.436161649535, 8895.644174233023, 9119.0, 9140.817183656356, 9416.576254068583, 8094.433389662726, 8106.756797296091, 8161.8367632647605, 8294.129116442808, 8332.083470818205, 2455.7789798918006, 2503.173952595639, 2509.736477669855, 2518.055729101587, 2526.2547548473062, 47232.291515627294, 48774.51225487735, 49022.0, 50304.0, 50576.24135637969, 7151.570905745672, 7173.856522869513, 7190.568565886064, 7209.71161153548, 7231.0, 13778.379972901244, 13834.446622135001, 13851.653708657162, 13856.653583660489, 13901.930490347484, 6068.089786532056, 6085.421884920926, 6427.132337134521, 6678.565893216925, 6725.9663701681175, 3661.9267614647556, 3676.0, 3719.5143113543445, 3761.9435708464393, 3844.3464611016193, 2732.180345896263, 2819.7744180465925, 2832.178668186244, 2836.2342167615043, 2845.9857700711777, 488.3041665626468, 490.35763150273254, 491.9237518184687, 498.9276554899519, 504.3090965377383, 462.5767422808093, 507.57617389480197, 528.5269683633127, 547.8356493052069, 556.7967691792547, 6726.39462448382, 7038.964805175941, 7188.784336469915, 7360.521566098187, 7405.074365704287, 442.9003474218275, 487.0575436530325, 576.7289373994216, 580.8083332500265, 586.548357764519, 3350.2127000155433, 3507.5615548056494, 3557.1996300832625, 3608.350496910581, 3714.609965953536, 53653.0, 55402.44597554053, 56091.439085608625, 74307.0, 76784.0, 50665.24002139971, 52838.73580632072, 54521.72739136358, 55110.72444637831, 56412.43587564072, 43989.12021759547, 44396.0, 44402.5578593174, 44892.77553612211, 45010.77494612506, 7109.537880037781, 7377.225391333833, 7608.163102058658, 7679.961600191963, 7829.217078292125, 26926.865365673046, 27990.720092798812, 29003.854980724962, 34878.0, 37151.25697485981, 36070.4589431164, 41252.1749565013, 42666.78666606647, 46259.76870115628, 46688.53311466842, 10028.648997285352, 10031.347962382422, 10309.896901030894, 10419.166466682798, 10747.90415868898, 10276.126529245097, 10510.894891050992, 10689.51897164614, 10779.472621498833, 11235.325880447199, 9386.15524602789, 9413.48225847585, 9567.9043209567, 9672.129508344282, 9795.85306220393, 10064.748381290527, 10125.52633669638, 10290.434026128634, 10434.247364136574, 10491.895081049397, 8989.153583279523, 9108.635654573744, 9187.494687791968, 9496.0, 9710.17463515609, 8024.679012839654, 8082.757517274491, 8168.877466837884, 8318.209770071833, 8645.697400590949, 7830.4518683691595, 8662.82674346522, 8796.868046979429, 8981.46111233302, 9105.089491050841], "value": 5479.443452006557, "unit": "score"}], "name": "dromaeo_css", "value": 5632.244627930638, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 115.0, 117.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 133.0, 172.0, 134.0, 127.0, 129.0, 128.0, 161.0, 128.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 170.0, 161.0, 161.0, 161.0, 161.0, 161.0, 160.0, 161.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 109.0, 77.0, 77.0, 76.0, 76.0, 98.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 118.0, 84.0, 85.0, 85.0, 105.0, 84.0, 85.0, 118.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 119.0, 119.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 99.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 67.0, 66.0, 66.0, 66.0, 67.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 86.0, 91.0, 84.0, 84.0, 92.0, 83.0, 90.0, 87.0, 83.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 141.0, 143.0, 144.0, 141.0, 141.0, 146.0, 141.0, 235.0, 141.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 179.0, 180.0, 189.0, 183.0, 182.0, 181.0, 178.0, 176.0, 177.0], "value": 180.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 70.0, 74.0, 70.0, 71.0, 70.0, 70.0, 69.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1571.7000000000003, "alertThreshold": 2.0}]} 01:52:22 INFO - Return code: 0 01:52:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:52:22 INFO - # TBPL SUCCESS # 01:52:22 INFO - Running post-action listener: _resource_record_post_action 01:52:22 INFO - [mozharness: 2016-11-18 09:52:22.766196Z] Finished run-tests step (success) 01:52:22 INFO - Running post-run listener: _resource_record_post_run 01:52:22 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393293824; Read time: 160; Write time: 275940 01:52:22 INFO - TinderboxPrint: CPU usage
13.0% 01:52:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 160 01:52:22 INFO - TinderboxPrint: I/O write bytes / time
393,293,824 / 275,940 01:52:22 INFO - TinderboxPrint: CPU idle
8,346.2 (86.9%) 01:52:22 INFO - TinderboxPrint: CPU user
1,205.7 (12.6%) 01:52:22 INFO - TinderboxPrint: Swap in / out
0 / 0 01:52:22 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 101240832; Read time: 0; Write time: 84476 01:52:22 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292052992; Read time: 160; Write time: 191464 01:52:23 INFO - Running post-run listener: _upload_blobber_files 01:52:23 INFO - Blob upload gear active. 01:52:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:52:23 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 01:52:23 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'] 01:52:23 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 01:52:23 INFO - (blobuploader) - INFO - Open directory for files ... 01:52:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:52:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:52:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:52:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:52:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:52:24 INFO - (blobuploader) - INFO - Done attempting. 01:52:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:52:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:52:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:52:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:52:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:52:27 INFO - (blobuploader) - INFO - Done attempting. 01:52:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:52:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:52:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:52:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:52:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:52:28 INFO - (blobuploader) - INFO - Done attempting. 01:52:28 INFO - (blobuploader) - INFO - Iteration through files over. 01:52:28 INFO - Return code: 0 01:52:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:52:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:52:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/32d9646b8137c587c1cefd1b1d93aabfe0a2a91167c41b882dfa760790a95af8e7659772d84a8f64efe4bf490be5e919ccb1856c0641dedf2851c6faf3afc740", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9ef6b82ea5c57529b9d09e5479457ca46a4d74bdb9372b9d13436cb86aec401fe38aa10454357f2e97ed56900cb6c9505531472c4e89da034277dfe1a47d11ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/51be9711cf3a17182b648aff71ab38dfdf7182b63a7a93b7a1006b92dec494f0261a371ab5b2cabf9d1930dfafc75fe0fb12d80255ccf27f8a399649782e3166"} 01:52:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:52:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:52:28 INFO - Contents: 01:52:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/32d9646b8137c587c1cefd1b1d93aabfe0a2a91167c41b882dfa760790a95af8e7659772d84a8f64efe4bf490be5e919ccb1856c0641dedf2851c6faf3afc740", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9ef6b82ea5c57529b9d09e5479457ca46a4d74bdb9372b9d13436cb86aec401fe38aa10454357f2e97ed56900cb6c9505531472c4e89da034277dfe1a47d11ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/51be9711cf3a17182b648aff71ab38dfdf7182b63a7a93b7a1006b92dec494f0261a371ab5b2cabf9d1930dfafc75fe0fb12d80255ccf27f8a399649782e3166"} 01:52:28 INFO - Running post-run listener: copy_logs_to_upload_dir 01:52:28 INFO - Copying logs to upload dir... 01:52:28 INFO - mkdir: /builds/slave/test/build/upload/logs 01:52:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.505303 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-11-18 01:52:28.163621) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 01:52:28.166991) ========= 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-1479461501.263097-1292696603 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/32d9646b8137c587c1cefd1b1d93aabfe0a2a91167c41b882dfa760790a95af8e7659772d84a8f64efe4bf490be5e919ccb1856c0641dedf2851c6faf3afc740", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9ef6b82ea5c57529b9d09e5479457ca46a4d74bdb9372b9d13436cb86aec401fe38aa10454357f2e97ed56900cb6c9505531472c4e89da034277dfe1a47d11ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/51be9711cf3a17182b648aff71ab38dfdf7182b63a7a93b7a1006b92dec494f0261a371ab5b2cabf9d1930dfafc75fe0fb12d80255ccf27f8a399649782e3166"} build_url:https://queue.taskcluster.net/v1/task/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011792 build_url: 'https://queue.taskcluster.net/v1/task/Pm1Et-O8R5aGbPlyKX7DEA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/32d9646b8137c587c1cefd1b1d93aabfe0a2a91167c41b882dfa760790a95af8e7659772d84a8f64efe4bf490be5e919ccb1856c0641dedf2851c6faf3afc740", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9ef6b82ea5c57529b9d09e5479457ca46a4d74bdb9372b9d13436cb86aec401fe38aa10454357f2e97ed56900cb6c9505531472c4e89da034277dfe1a47d11ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/51be9711cf3a17182b648aff71ab38dfdf7182b63a7a93b7a1006b92dec494f0261a371ab5b2cabf9d1930dfafc75fe0fb12d80255ccf27f8a399649782e3166"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 01:52:28.192720) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 01:52:28.193063) ========= 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-1479461501.263097-1292696603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 01:52:28.275342) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 01:52:28.275680) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 01:52:28.275960) ========= ========= Total master_lag: 0.16 =========