builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1477745685.03 results: success (0) buildid: 20161029030204 builduid: 4d17e5fe0b4b4693a7b496413207fdb4 revision: 1561c917ee27c3ea04bd69467e5b8c7c08102f2a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 05:54:45.031919) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 05:54:45.032391) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 05:54:45.032662) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 05:54:45.047184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 05:54:45.047649) ========= 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=03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-29 05:54:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.7M=0s 2016-10-29 05:54:45 (37.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109090 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 05:54:45.170177) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 05:54:45.170465) ========= 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=03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016575 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 05:54:45.219790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 05:54:45.220111) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1561c917ee27c3ea04bd69467e5b8c7c08102f2a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1561c917ee27c3ea04bd69467e5b8c7c08102f2a --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=03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-29 05:54:45,411 truncating revision to first 12 chars 2016-10-29 05:54:45,411 Setting DEBUG logging. 2016-10-29 05:54:45,411 attempt 1/10 2016-10-29 05:54:45,411 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1561c917ee27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-29 05:54:45,854 unpacking tar archive at: mozilla-central-1561c917ee27/testing/mozharness/ program finished with exit code 0 elapsedTime=0.746782 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 05:54:45.979273) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 05:54:45.979583) ========= script_repo_revision: 1561c917ee27c3ea04bd69467e5b8c7c08102f2a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 05:54:45.979970) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 05:54:45.980263) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 05:54:45.990434) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-29 05:54:45.990702) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:54:46 INFO - MultiFileLogger online at 20161029 05:54:46 in /builds/slave/test 05:54:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:54:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:54:46 INFO - {'append_to_log': False, 05:54:46 INFO - 'base_work_dir': '/builds/slave/test', 05:54:46 INFO - 'blob_upload_branch': 'Firefox', 05:54:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:54:46 INFO - 'branch': 'Firefox', 05:54:46 INFO - 'buildbot_json_path': 'buildprops.json', 05:54:46 INFO - 'config_files': ('talos/linux_config.py',), 05:54:46 INFO - 'default_actions': ('clobber', 05:54:46 INFO - 'read-buildbot-config', 05:54:46 INFO - 'download-and-extract', 05:54:46 INFO - 'populate-webroot', 05:54:46 INFO - 'create-virtualenv', 05:54:46 INFO - 'install', 05:54:46 INFO - 'run-tests'), 05:54:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:54:46 INFO - 'download_minidump_stackwalk': True, 05:54:46 INFO - 'download_symbols': 'ondemand', 05:54:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:54:46 INFO - 'tooltool.py': '/tools/tooltool.py', 05:54:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:54:46 INFO - '/tools/misc-python/virtualenv.py')}, 05:54:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:54:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:54:46 INFO - 'installer_path': 'installer.exe', 05:54:46 INFO - 'log_level': 'info', 05:54:46 INFO - 'log_name': 'talos', 05:54:46 INFO - 'log_to_console': True, 05:54:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:54:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:54:46 INFO - 'opt_config_files': (), 05:54:46 INFO - 'pip_index': False, 05:54:46 INFO - 'sps_profile': False, 05:54:46 INFO - 'sps_profile_interval': 0, 05:54:46 INFO - 'suite': 'dromaeojs', 05:54:46 INFO - 'system_bits': '32', 05:54:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:54:46 INFO - 'title': 'talos-linux64-ix-047', 05:54:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:54:46 INFO - 'use_talos_json': True, 05:54:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:54:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:54:46 INFO - 'work_dir': 'build'} 05:54:46 INFO - [mozharness: 2016-10-29 12:54:46.273621Z] Running clobber step. 05:54:46 INFO - Running pre-action listener: _resource_record_pre_action 05:54:46 INFO - Running main action method: clobber 05:54:46 INFO - rmtree: /builds/slave/test/build 05:54:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:54:46 INFO - Running post-action listener: _resource_record_post_action 05:54:46 INFO - [mozharness: 2016-10-29 12:54:46.728239Z] Finished clobber step (success) 05:54:46 INFO - [mozharness: 2016-10-29 12:54:46.728340Z] Running read-buildbot-config step. 05:54:46 INFO - Running pre-action listener: _resource_record_pre_action 05:54:46 INFO - Running main action method: read_buildbot_config 05:54:46 INFO - Using buildbot properties: 05:54:46 INFO - { 05:54:46 INFO - "project": "", 05:54:46 INFO - "product": "firefox", 05:54:46 INFO - "script_repo_revision": "production", 05:54:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:54:46 INFO - "repository": "", 05:54:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:54:46 INFO - "buildid": "20161029030204", 05:54:46 INFO - "stage_platform": "linux64-pgo", 05:54:46 INFO - "basedir": "/builds/slave/test", 05:54:46 INFO - "nightly_build": "True", 05:54:46 INFO - "buildnumber": 49, 05:54:46 INFO - "slavename": "talos-linux64-ix-047", 05:54:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:54:46 INFO - "platform": "ubuntu64_hw", 05:54:46 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:54:46 INFO - "branch": "mozilla-central", 05:54:46 INFO - "repo_path": "mozilla-central", 05:54:46 INFO - "revision": "1561c917ee27c3ea04bd69467e5b8c7c08102f2a", 05:54:46 INFO - "pgo_build": "True", 05:54:46 INFO - "builduid": "4d17e5fe0b4b4693a7b496413207fdb4", 05:54:46 INFO - "slavebuilddir": "test" 05:54:46 INFO - } 05:54:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:54:46 INFO - Running post-action listener: _resource_record_post_action 05:54:46 INFO - [mozharness: 2016-10-29 12:54:46.731124Z] Finished read-buildbot-config step (success) 05:54:46 INFO - [mozharness: 2016-10-29 12:54:46.731213Z] Running download-and-extract step. 05:54:46 INFO - Running pre-action listener: _resource_record_pre_action 05:54:46 INFO - Running main action method: download_and_extract 05:54:46 INFO - mkdir: /builds/slave/test/build/tests 05:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:46 INFO - trying https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:54:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:54:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:54:47 INFO - Downloaded 1361 bytes. 05:54:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:54:47 INFO - Using the following test package requirements: 05:54:47 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:54:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:54:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:54:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:47 INFO - u'jsshell-linux-x86_64.zip'], 05:54:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:54:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:54:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:54:47 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:54:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:54:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:54:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:54:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:54:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:54:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:54:48 INFO - Http code: 200 05:54:48 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 05:54:48 INFO - x-amz-cf-id: crKiErJknHEKU82450j91Ozk5FKmTJ81ufGwRxcdrkfiSPIBXgEHoQ== 05:54:48 INFO - x-amz-version-id: _FReOTPXriLYnscwQ9kP5sTCw9Jyttli 05:54:49 INFO - Expected file size: 21992639 05:54:49 INFO - Obtained file size: 21992639 05:54:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:54:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:54:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:54:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:54:53 INFO - Http code: 200 05:54:53 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 05:54:53 INFO - x-amz-cf-id: d7mro_LsgQbG-o_mt7Tc4sggtTy8xtZrNMRVFNSdxLh47uL3ODThNg== 05:54:53 INFO - x-amz-version-id: _FReOTPXriLYnscwQ9kP5sTCw9Jyttli 05:54:53 INFO - Expected file size: 21992639 05:54:53 INFO - Obtained file size: 21992639 05:54:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:54:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:54:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:54:59 INFO - Http code: 200 05:54:59 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 05:54:59 INFO - x-amz-cf-id: en6ipTKu8RY_oIE244NRGgnE1zGNV5YAYzTewG-206KV72lmC89efg== 05:54:59 INFO - x-amz-version-id: WRc5ZrZoRFvY8DyxmekEXSsCNxpuXQ81 05:54:59 INFO - Expected file size: 14409028 05:54:59 INFO - Obtained file size: 14409028 05:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:00 INFO - trying https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:55:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:55:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:55:02 INFO - Downloaded 59366727 bytes. 05:55:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:55:02 INFO - mkdir: /builds/slave/test/properties 05:55:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:55:02 INFO - Writing to file /builds/slave/test/properties/build_url 05:55:02 INFO - Contents: 05:55:02 INFO - build_url:https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:55:03 INFO - Running post-action listener: _resource_record_post_action 05:55:03 INFO - Running post-action listener: set_extra_try_arguments 05:55:03 INFO - [mozharness: 2016-10-29 12:55:03.137835Z] Finished download-and-extract step (success) 05:55:03 INFO - [mozharness: 2016-10-29 12:55:03.138062Z] Running populate-webroot step. 05:55:03 INFO - Running pre-action listener: _resource_record_pre_action 05:55:03 INFO - Running main action method: populate_webroot 05:55:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:55:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:55:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:55:03 INFO - '--tppagecycles', 05:55:03 INFO - '7'], 05:55:03 INFO - 'tests': ['tsvgm']}}, 05:55:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:55:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:55:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:55:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:55:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:03 INFO - 'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:55:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:55:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:03 INFO - 'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['damp', 'tps']}, 05:55:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:03 INFO - 'tests': ['damp', 'tps']}, 05:55:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['dromaeo_dom']}, 05:55:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:55:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['basic_compositor_video']}, 05:55:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:55:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['a11yr', 05:55:03 INFO - 'ts_paint', 05:55:03 INFO - 'tpaint', 05:55:03 INFO - 'sessionrestore', 05:55:03 INFO - 'sessionrestore_no_auto_restore', 05:55:03 INFO - 'tabpaint']}, 05:55:03 INFO - 'other-e10s': {'tests': ['a11yr', 05:55:03 INFO - 'ts_paint', 05:55:03 INFO - 'tpaint', 05:55:03 INFO - 'sessionrestore', 05:55:03 INFO - 'sessionrestore_no_auto_restore', 05:55:03 INFO - 'tabpaint']}, 05:55:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:55:03 INFO - 'ts_paint', 05:55:03 INFO - 'tpaint', 05:55:03 INFO - 'sessionrestore', 05:55:03 INFO - 'sessionrestore_no_auto_restore', 05:55:03 INFO - 'tabpaint']}, 05:55:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:55:03 INFO - 'ts_paint', 05:55:03 INFO - 'tpaint', 05:55:03 INFO - 'sessionrestore', 05:55:03 INFO - 'sessionrestore_no_auto_restore', 05:55:03 INFO - 'tabpaint']}, 05:55:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['a11yr', 05:55:03 INFO - 'ts_paint', 05:55:03 INFO - 'tpaint', 05:55:03 INFO - 'sessionrestore', 05:55:03 INFO - 'sessionrestore_no_auto_restore', 05:55:03 INFO - 'tabpaint']}, 05:55:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['a11yr', 05:55:03 INFO - 'ts_paint', 05:55:03 INFO - 'tpaint', 05:55:03 INFO - 'sessionrestore', 05:55:03 INFO - 'sessionrestore_no_auto_restore', 05:55:03 INFO - 'tabpaint']}, 05:55:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['tsvgx', 05:55:03 INFO - 'tsvgr_opacity', 05:55:03 INFO - 'tart', 05:55:03 INFO - 'tscrollx', 05:55:03 INFO - 'cart']}, 05:55:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:55:03 INFO - 'tsvgr_opacity', 05:55:03 INFO - 'tart', 05:55:03 INFO - 'tscrollx', 05:55:03 INFO - 'cart']}, 05:55:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:03 INFO - 'talos_options': ['--disable-e10s'], 05:55:03 INFO - 'tests': ['tp5o']}, 05:55:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:03 INFO - 'tests': ['tp5o']}, 05:55:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:03 INFO - 'talos_options': ['--disable-e10s', 05:55:03 INFO - '--xperf_path', 05:55:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:55:03 INFO - 'tests': ['tp5n']}, 05:55:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:03 INFO - 'talos_options': ['--xperf_path', 05:55:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:55:03 INFO - 'tests': ['tp5n']}}, 05:55:03 INFO - 'talos.zip': {'path': '', 05:55:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:55:03 INFO - Running post-action listener: _resource_record_post_action 05:55:03 INFO - [mozharness: 2016-10-29 12:55:03.153429Z] Finished populate-webroot step (success) 05:55:03 INFO - [mozharness: 2016-10-29 12:55:03.153517Z] Running create-virtualenv step. 05:55:03 INFO - Running pre-action listener: _resource_record_pre_action 05:55:03 INFO - Running main action method: create_virtualenv 05:55:03 INFO - Creating virtualenv /builds/slave/test/build/venv 05:55:03 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 05:55:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:55:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:55:03 INFO - Using real prefix '/usr' 05:55:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:55:03 INFO - Installing distribute.............................................................................................................................................................................................done. 05:55:05 INFO - Installing pip.................done. 05:55:05 INFO - Return code: 0 05:55:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:55:05 INFO - Reading from file tmpfile_stdout 05:55:05 INFO - Output received: 05:55:05 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) 05:55:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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')]} 05:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6e67c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f03790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f00930>, '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 0x1f01830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408', '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 05:55: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', 'pip>=1.5'] in /builds/slave/test/build 05:55: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 pip>=1.5 05:55:05 INFO - Using env: {'DISPLAY': ':0', 05:55:05 INFO - 'HOME': '/home/cltbld', 05:55:05 INFO - 'LANG': 'en_US.UTF-8', 05:55:05 INFO - 'LANGUAGE': 'en_US:en', 05:55:05 INFO - 'LOGNAME': 'cltbld', 05:55:05 INFO - 'MAIL': '/var/mail/cltbld', 05:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:05 INFO - 'MOZ_NO_REMOTE': '1', 05:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:05 INFO - 'NO_EM_RESTART': '1', 05:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:05 INFO - 'PWD': '/builds/slave/test', 05:55:05 INFO - 'SHELL': '/bin/bash', 05:55:05 INFO - 'SHLVL': '1', 05:55:05 INFO - 'TERM': 'linux', 05:55:05 INFO - 'TMOUT': '86400', 05:55:05 INFO - 'USER': 'cltbld', 05:55:05 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408', 05:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:05 INFO - '_': '/tools/buildbot/bin/python'} 05:55:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:06 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 05:55:06 INFO - Cleaning up... 05:55:06 INFO - Return code: 0 05:55:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:55:06 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')]} 05:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:06 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')]} 05:55:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:06 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 0x7f6e67c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f03790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f00930>, '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 0x1f01830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408', '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 05:55:06 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 05:55:06 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 05:55:06 INFO - Using env: {'DISPLAY': ':0', 05:55:06 INFO - 'HOME': '/home/cltbld', 05:55:06 INFO - 'LANG': 'en_US.UTF-8', 05:55:06 INFO - 'LANGUAGE': 'en_US:en', 05:55:06 INFO - 'LOGNAME': 'cltbld', 05:55:06 INFO - 'MAIL': '/var/mail/cltbld', 05:55:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:06 INFO - 'MOZ_NO_REMOTE': '1', 05:55:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:06 INFO - 'NO_EM_RESTART': '1', 05:55:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:06 INFO - 'PWD': '/builds/slave/test', 05:55:06 INFO - 'SHELL': '/bin/bash', 05:55:06 INFO - 'SHLVL': '1', 05:55:06 INFO - 'TERM': 'linux', 05:55:06 INFO - 'TMOUT': '86400', 05:55:06 INFO - 'USER': 'cltbld', 05:55:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408', 05:55:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:06 INFO - '_': '/tools/buildbot/bin/python'} 05:55:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:06 INFO - Downloading/unpacking psutil>=3.1.1 05:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:55:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:55:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:55:08 INFO - Installing collected packages: psutil 05:55:08 INFO - Running setup.py install for psutil 05:55:08 INFO - building 'psutil._psutil_linux' extension 05:55:08 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 05:55:08 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 05:55:08 INFO - building 'psutil._psutil_posix' extension 05:55:08 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 05:55:08 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 05:55:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:55:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:55:08 INFO - Successfully installed psutil 05:55:08 INFO - Cleaning up... 05:55:08 INFO - Return code: 0 05:55:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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')]} 05:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6e67c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f03790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f00930>, '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 0x1f01830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408', '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 05:55: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:55: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 mozsystemmonitor==0.3 05:55:08 INFO - Using env: {'DISPLAY': ':0', 05:55:08 INFO - 'HOME': '/home/cltbld', 05:55:08 INFO - 'LANG': 'en_US.UTF-8', 05:55:08 INFO - 'LANGUAGE': 'en_US:en', 05:55:08 INFO - 'LOGNAME': 'cltbld', 05:55:08 INFO - 'MAIL': '/var/mail/cltbld', 05:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:08 INFO - 'MOZ_NO_REMOTE': '1', 05:55:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:08 INFO - 'NO_EM_RESTART': '1', 05:55:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:08 INFO - 'PWD': '/builds/slave/test', 05:55:08 INFO - 'SHELL': '/bin/bash', 05:55:08 INFO - 'SHLVL': '1', 05:55:08 INFO - 'TERM': 'linux', 05:55:08 INFO - 'TMOUT': '86400', 05:55:08 INFO - 'USER': 'cltbld', 05:55:08 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408', 05:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:08 INFO - '_': '/tools/buildbot/bin/python'} 05:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:55:09 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 05:55:09 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 05:55:09 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 05:55:09 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 05:55:09 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 05:55:09 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 05:55:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:55:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:55:11 INFO - Installing collected packages: mozsystemmonitor 05:55:11 INFO - Running setup.py install for mozsystemmonitor 05:55:11 INFO - Successfully installed mozsystemmonitor 05:55:11 INFO - Cleaning up... 05:55:11 INFO - Return code: 0 05:55:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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')]} 05:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:11 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 0x7f6e67c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f03790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f00930>, '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 0x1f01830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408', '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 05:55:11 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 05:55:11 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 05:55:11 INFO - Using env: {'DISPLAY': ':0', 05:55:11 INFO - 'HOME': '/home/cltbld', 05:55:11 INFO - 'LANG': 'en_US.UTF-8', 05:55:11 INFO - 'LANGUAGE': 'en_US:en', 05:55:11 INFO - 'LOGNAME': 'cltbld', 05:55:11 INFO - 'MAIL': '/var/mail/cltbld', 05:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:11 INFO - 'MOZ_NO_REMOTE': '1', 05:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:11 INFO - 'NO_EM_RESTART': '1', 05:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:11 INFO - 'PWD': '/builds/slave/test', 05:55:11 INFO - 'SHELL': '/bin/bash', 05:55:11 INFO - 'SHLVL': '1', 05:55:11 INFO - 'TERM': 'linux', 05:55:11 INFO - 'TMOUT': '86400', 05:55:11 INFO - 'USER': 'cltbld', 05:55:11 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408', 05:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:11 INFO - '_': '/tools/buildbot/bin/python'} 05:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:11 INFO - Downloading/unpacking jsonschema==2.5.1 05:55:11 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 05:55:11 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 05:55:11 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 05:55:11 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 05:55:11 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 05:55:11 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 05:55:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:55:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:55:13 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 05:55:13 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 05:55:13 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 05:55:13 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 05:55:13 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 05:55:13 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 05:55:13 INFO - Downloading functools32-3.2.3-2.tar.gz 05:55:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:55:13 INFO - warning: no files found matching '*.txt' 05:55:13 INFO - no previously-included directories found matching 'build' 05:55:13 INFO - no previously-included directories found matching 'dist' 05:55:13 INFO - no previously-included directories found matching '.git*' 05:55:13 INFO - Installing collected packages: jsonschema, functools32 05:55:13 INFO - Running setup.py install for functools32 05:55:13 INFO - warning: no files found matching '*.txt' 05:55:13 INFO - no previously-included directories found matching 'build' 05:55:13 INFO - no previously-included directories found matching 'dist' 05:55:13 INFO - no previously-included directories found matching '.git*' 05:55:13 INFO - Successfully installed jsonschema functools32 05:55:13 INFO - Cleaning up... 05:55:13 INFO - Return code: 0 05:55:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6e67c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f03790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f00930>, '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 0x1f01830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408', '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 05:55:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:55:13 INFO - Using env: {'DISPLAY': ':0', 05:55:13 INFO - 'HOME': '/home/cltbld', 05:55:13 INFO - 'LANG': 'en_US.UTF-8', 05:55:13 INFO - 'LANGUAGE': 'en_US:en', 05:55:13 INFO - 'LOGNAME': 'cltbld', 05:55:13 INFO - 'MAIL': '/var/mail/cltbld', 05:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:13 INFO - 'MOZ_NO_REMOTE': '1', 05:55:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:13 INFO - 'NO_EM_RESTART': '1', 05:55:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:13 INFO - 'PWD': '/builds/slave/test', 05:55:13 INFO - 'SHELL': '/bin/bash', 05:55:13 INFO - 'SHLVL': '1', 05:55:13 INFO - 'TERM': 'linux', 05:55:13 INFO - 'TMOUT': '86400', 05:55:13 INFO - 'USER': 'cltbld', 05:55:13 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408', 05:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:13 INFO - '_': '/tools/buildbot/bin/python'} 05:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:55:14 INFO - Cleaning up... 05:55:14 INFO - Return code: 0 05:55:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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')]} 05:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:14 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 0x7f6e67c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f03790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f00930>, '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 0x1f01830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408', '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 05:55:14 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 05:55:14 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 05:55:14 INFO - Using env: {'DISPLAY': ':0', 05:55:14 INFO - 'HOME': '/home/cltbld', 05:55:14 INFO - 'LANG': 'en_US.UTF-8', 05:55:14 INFO - 'LANGUAGE': 'en_US:en', 05:55:14 INFO - 'LOGNAME': 'cltbld', 05:55:14 INFO - 'MAIL': '/var/mail/cltbld', 05:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:14 INFO - 'MOZ_NO_REMOTE': '1', 05:55:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:14 INFO - 'NO_EM_RESTART': '1', 05:55:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:14 INFO - 'PWD': '/builds/slave/test', 05:55:14 INFO - 'SHELL': '/bin/bash', 05:55:14 INFO - 'SHLVL': '1', 05:55:14 INFO - 'TERM': 'linux', 05:55:14 INFO - 'TMOUT': '86400', 05:55:14 INFO - 'USER': 'cltbld', 05:55:14 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408', 05:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:14 INFO - '_': '/tools/buildbot/bin/python'} 05:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:14 INFO - Downloading/unpacking blobuploader==1.2.4 05:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:16 INFO - Downloading blobuploader-1.2.4.tar.gz 05:55:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:55:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:55:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55:17 INFO - Downloading docopt-0.6.1.tar.gz 05:55:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:55:17 INFO - Installing collected packages: blobuploader, requests, docopt 05:55:17 INFO - Running setup.py install for blobuploader 05:55:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:55:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:55:17 INFO - Running setup.py install for requests 05:55:17 INFO - Running setup.py install for docopt 05:55:17 INFO - Successfully installed blobuploader requests docopt 05:55:17 INFO - Cleaning up... 05:55:17 INFO - Return code: 0 05:55:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:17 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')]} 05:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:17 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')]} 05:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:17 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 0x7f6e67c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f03790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f00930>, '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 0x1f01830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408', '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 05:55:17 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 05:55:17 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 05:55:17 INFO - Using env: {'DISPLAY': ':0', 05:55:17 INFO - 'HOME': '/home/cltbld', 05:55:17 INFO - 'LANG': 'en_US.UTF-8', 05:55:17 INFO - 'LANGUAGE': 'en_US:en', 05:55:17 INFO - 'LOGNAME': 'cltbld', 05:55:17 INFO - 'MAIL': '/var/mail/cltbld', 05:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:17 INFO - 'MOZ_NO_REMOTE': '1', 05:55:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:17 INFO - 'NO_EM_RESTART': '1', 05:55:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:17 INFO - 'PWD': '/builds/slave/test', 05:55:17 INFO - 'SHELL': '/bin/bash', 05:55:17 INFO - 'SHLVL': '1', 05:55:17 INFO - 'TERM': 'linux', 05:55:17 INFO - 'TMOUT': '86400', 05:55:17 INFO - 'USER': 'cltbld', 05:55:17 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408', 05:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:17 INFO - '_': '/tools/buildbot/bin/python'} 05:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:17 INFO - Running setup.py (path:/tmp/pip-sfFYNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:17 INFO - Running setup.py (path:/tmp/pip-IVsGhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:18 INFO - Running setup.py (path:/tmp/pip-oP5j06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:18 INFO - Running setup.py (path:/tmp/pip-Gekei4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:18 INFO - Running setup.py (path:/tmp/pip-jQurPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:18 INFO - Running setup.py (path:/tmp/pip-iCC6Jn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:18 INFO - Running setup.py (path:/tmp/pip-Bd5enf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:18 INFO - Running setup.py (path:/tmp/pip-O2krhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:18 INFO - Running setup.py (path:/tmp/pip-ShcBvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:18 INFO - Running setup.py (path:/tmp/pip-RloCLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:18 INFO - Running setup.py (path:/tmp/pip-ma5ulo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:18 INFO - Running setup.py (path:/tmp/pip-CSdZ3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:18 INFO - Running setup.py (path:/tmp/pip-anoXug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:18 INFO - Running setup.py (path:/tmp/pip-KTqoER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:18 INFO - Running setup.py (path:/tmp/pip-WJpjOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:18 INFO - Running setup.py (path:/tmp/pip-OEH3Bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:19 INFO - Running setup.py (path:/tmp/pip-uL8uZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:55:19 INFO - Running setup.py install for manifestparser 05:55:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:55:19 INFO - Running setup.py install for mozcrash 05:55:19 INFO - Running setup.py install for mozdebug 05:55:19 INFO - Running setup.py install for mozdevice 05:55:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:55:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:55:19 INFO - Running setup.py install for mozfile 05:55:19 INFO - Running setup.py install for mozhttpd 05:55:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:55:19 INFO - Running setup.py install for mozinfo 05:55:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:55:19 INFO - Running setup.py install for mozInstall 05:55:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:55:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:55:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:55:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:55:19 INFO - Running setup.py install for mozleak 05:55:20 INFO - Running setup.py install for mozlog 05:55:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:55:20 INFO - Running setup.py install for moznetwork 05:55:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:55:20 INFO - Running setup.py install for mozprocess 05:55:20 INFO - Running setup.py install for mozprofile 05:55:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:55:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:55:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:55:20 INFO - Running setup.py install for mozrunner 05:55:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:55:20 INFO - Running setup.py install for mozscreenshot 05:55:20 INFO - Running setup.py install for moztest 05:55:20 INFO - Running setup.py install for mozversion 05:55:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:55:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:55:20 INFO - Cleaning up... 05:55:20 INFO - Return code: 0 05:55:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:20 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')]} 05:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:20 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')]} 05:55:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:20 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 0x7f6e67c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f03790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f00930>, '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 0x1f01830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408', '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 05:55:20 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 05:55:20 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 05:55:20 INFO - Using env: {'DISPLAY': ':0', 05:55:20 INFO - 'HOME': '/home/cltbld', 05:55:20 INFO - 'LANG': 'en_US.UTF-8', 05:55:20 INFO - 'LANGUAGE': 'en_US:en', 05:55:20 INFO - 'LOGNAME': 'cltbld', 05:55:20 INFO - 'MAIL': '/var/mail/cltbld', 05:55:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:20 INFO - 'MOZ_NO_REMOTE': '1', 05:55:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:20 INFO - 'NO_EM_RESTART': '1', 05:55:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:20 INFO - 'PWD': '/builds/slave/test', 05:55:20 INFO - 'SHELL': '/bin/bash', 05:55:20 INFO - 'SHLVL': '1', 05:55:20 INFO - 'TERM': 'linux', 05:55:20 INFO - 'TMOUT': '86400', 05:55:20 INFO - 'USER': 'cltbld', 05:55:20 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408', 05:55:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:20 INFO - '_': '/tools/buildbot/bin/python'} 05:55:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:21 INFO - Running setup.py (path:/tmp/pip-Sc76wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55:21 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)) 05:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:21 INFO - Running setup.py (path:/tmp/pip-EIZNP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:21 INFO - Running setup.py (path:/tmp/pip-erXyBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55:21 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)) 05:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:21 INFO - Running setup.py (path:/tmp/pip-N8BEMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55:21 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)) 05:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:21 INFO - Running setup.py (path:/tmp/pip-2Wn587-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55:21 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)) 05:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:21 INFO - Running setup.py (path:/tmp/pip-a1141P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55:21 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)) 05:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:21 INFO - Running setup.py (path:/tmp/pip-pGloob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:21 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)) 05:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:21 INFO - Running setup.py (path:/tmp/pip-_KXsYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:21 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)) 05:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:21 INFO - Running setup.py (path:/tmp/pip-9UGQDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:21 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)) 05:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:21 INFO - Running setup.py (path:/tmp/pip-56hmGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:21 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)) 05:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:21 INFO - Running setup.py (path:/tmp/pip-RZapCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55:21 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)) 05:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:21 INFO - Running setup.py (path:/tmp/pip-nCwzRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55:22 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)) 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:22 INFO - Running setup.py (path:/tmp/pip-mFZRhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55:22 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)) 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:22 INFO - Running setup.py (path:/tmp/pip-XPGQrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:22 INFO - Running setup.py (path:/tmp/pip-gxaLYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:22 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)) 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:22 INFO - Running setup.py (path:/tmp/pip-M5xLdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55:22 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)) 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:22 INFO - Running setup.py (path:/tmp/pip-rRibaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55:22 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)) 05:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:55:22 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)) 05:55:22 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)) 05:55:22 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)) 05:55:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:55:22 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 05:55:22 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 05:55:22 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 05:55:22 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 05:55:22 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 05:55:22 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 05:55:24 INFO - Downloading blessings-1.6.tar.gz 05:55:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:55:24 INFO - Installing collected packages: blessings 05:55:24 INFO - Running setup.py install for blessings 05:55:24 INFO - Successfully installed blessings 05:55:24 INFO - Cleaning up... 05:55:24 INFO - Return code: 0 05:55:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:55:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:24 INFO - Reading from file tmpfile_stdout 05:55:24 INFO - Current package versions: 05:55:24 INFO - argparse == 1.2.1 05:55:24 INFO - blessings == 1.6 05:55:24 INFO - blobuploader == 1.2.4 05:55:24 INFO - docopt == 0.6.1 05:55:24 INFO - functools32 == 3.2.3-2 05:55:24 INFO - jsonschema == 2.5.1 05:55:24 INFO - manifestparser == 1.1 05:55:24 INFO - mozInstall == 1.12 05:55:24 INFO - mozcrash == 0.17 05:55:24 INFO - mozdebug == 0.1 05:55:24 INFO - mozdevice == 0.48 05:55:24 INFO - mozfile == 1.2 05:55:24 INFO - mozhttpd == 0.7 05:55:24 INFO - mozinfo == 0.9 05:55:24 INFO - mozleak == 0.1 05:55:24 INFO - mozlog == 3.4 05:55:24 INFO - moznetwork == 0.27 05:55:24 INFO - mozprocess == 0.23 05:55:24 INFO - mozprofile == 0.28 05:55:24 INFO - mozrunner == 6.12 05:55:24 INFO - mozscreenshot == 0.1 05:55:24 INFO - mozsystemmonitor == 0.3 05:55:24 INFO - moztest == 0.7 05:55:24 INFO - mozversion == 1.4 05:55:24 INFO - psutil == 3.1.1 05:55:24 INFO - requests == 1.2.3 05:55:24 INFO - wsgiref == 0.1.2 05:55:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:24 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 0x7f6e67c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f03790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f00930>, '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 0x1f01830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408', '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 05:55:24 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 05:55:24 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 05:55:24 INFO - Using env: {'DISPLAY': ':0', 05:55:24 INFO - 'HOME': '/home/cltbld', 05:55:24 INFO - 'LANG': 'en_US.UTF-8', 05:55:24 INFO - 'LANGUAGE': 'en_US:en', 05:55:24 INFO - 'LOGNAME': 'cltbld', 05:55:24 INFO - 'MAIL': '/var/mail/cltbld', 05:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:24 INFO - 'MOZ_NO_REMOTE': '1', 05:55:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:24 INFO - 'NO_EM_RESTART': '1', 05:55:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:24 INFO - 'PWD': '/builds/slave/test', 05:55:24 INFO - 'SHELL': '/bin/bash', 05:55:24 INFO - 'SHLVL': '1', 05:55:24 INFO - 'TERM': 'linux', 05:55:24 INFO - 'TMOUT': '86400', 05:55:24 INFO - 'USER': 'cltbld', 05:55:24 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408', 05:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:24 INFO - '_': '/tools/buildbot/bin/python'} 05:55:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:25 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)) 05:55:25 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)) 05:55:25 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)) 05:55:25 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)) 05:55:25 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)) 05:55:25 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)) 05:55:25 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)) 05:55:25 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)) 05:55:25 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)) 05:55:25 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)) 05:55:25 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)) 05:55:25 INFO - Cleaning up... 05:55:25 INFO - Return code: 0 05:55:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:25 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 0x7f6e67c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f03790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f00930>, '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 0x1f01830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408', '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 05:55:25 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 05:55:25 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 05:55:25 INFO - Using env: {'DISPLAY': ':0', 05:55:25 INFO - 'HOME': '/home/cltbld', 05:55:25 INFO - 'LANG': 'en_US.UTF-8', 05:55:25 INFO - 'LANGUAGE': 'en_US:en', 05:55:25 INFO - 'LOGNAME': 'cltbld', 05:55:25 INFO - 'MAIL': '/var/mail/cltbld', 05:55:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:25 INFO - 'MOZ_NO_REMOTE': '1', 05:55:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:25 INFO - 'NO_EM_RESTART': '1', 05:55:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:25 INFO - 'PWD': '/builds/slave/test', 05:55:25 INFO - 'SHELL': '/bin/bash', 05:55:25 INFO - 'SHLVL': '1', 05:55:25 INFO - 'TERM': 'linux', 05:55:25 INFO - 'TMOUT': '86400', 05:55:25 INFO - 'USER': 'cltbld', 05:55:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408', 05:55:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:25 INFO - '_': '/tools/buildbot/bin/python'} 05:55:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:55:25 INFO - Cleaning up... 05:55:25 INFO - Return code: 0 05:55:25 INFO - Running post-action listener: _resource_record_post_action 05:55:25 INFO - Running post-action listener: _start_resource_monitoring 05:55:25 INFO - Starting resource monitoring. 05:55:25 INFO - [mozharness: 2016-10-29 12:55:25.310073Z] Finished create-virtualenv step (success) 05:55:25 INFO - [mozharness: 2016-10-29 12:55:25.310584Z] Running install step. 05:55:25 INFO - Running pre-action listener: _resource_record_pre_action 05:55:25 INFO - Running main action method: install 05:55:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:25 INFO - Reading from file tmpfile_stdout 05:55:25 INFO - Detecting whether we're running mozinstall >=1.0... 05:55:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:55:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:55:25 INFO - Reading from file tmpfile_stdout 05:55:25 INFO - Output received: 05:55:25 INFO - Usage: mozinstall [options] installer 05:55:25 INFO - Options: 05:55:25 INFO - -h, --help show this help message and exit 05:55:25 INFO - -d DEST, --destination=DEST 05:55:25 INFO - Directory to install application into. [default: 05:55:25 INFO - "/builds/slave/test"] 05:55:25 INFO - --app=APP Application being installed. [default: firefox] 05:55:25 INFO - mkdir: /builds/slave/test/build/application 05:55:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:55:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:55:42 INFO - Reading from file tmpfile_stdout 05:55:42 INFO - Output received: 05:55:42 INFO - /builds/slave/test/build/application/firefox/firefox 05:55:42 INFO - Running post-action listener: _resource_record_post_action 05:55:42 INFO - [mozharness: 2016-10-29 12:55:42.472062Z] Finished install step (success) 05:55:42 INFO - [mozharness: 2016-10-29 12:55:42.472307Z] Running run-tests step. 05:55:42 INFO - Running pre-action listener: _resource_record_pre_action 05:55:42 INFO - Running main action method: run_tests 05:55:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:55:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:55:42 INFO - Python 2.7.3 05:55:42 INFO - Return code: 0 05:55:42 INFO - grabbing minidump binary from tooltool 05:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:42 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 0x1f00930>, '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 0x1f01830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:55:42 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 05:55:42 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 05:55:42 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 05:55:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:55:42 INFO - Return code: 0 05:55:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:55:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:55:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:55:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:55:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:55:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 05:55:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 05:55:42 INFO - Using env: {'DISPLAY': ':0', 05:55:42 INFO - 'HOME': '/home/cltbld', 05:55:42 INFO - 'LANG': 'en_US.UTF-8', 05:55:42 INFO - 'LANGUAGE': 'en_US:en', 05:55:42 INFO - 'LOGNAME': 'cltbld', 05:55:42 INFO - 'MAIL': '/var/mail/cltbld', 05:55:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:55:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:42 INFO - 'MOZ_NO_REMOTE': '1', 05:55:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:55:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:42 INFO - 'NO_EM_RESTART': '1', 05:55:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:42 INFO - 'PWD': '/builds/slave/test', 05:55:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:55:42 INFO - 'SHELL': '/bin/bash', 05:55:42 INFO - 'SHLVL': '1', 05:55:42 INFO - 'TERM': 'linux', 05:55:42 INFO - 'TMOUT': '86400', 05:55:42 INFO - 'USER': 'cltbld', 05:55:42 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408', 05:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:42 INFO - '_': '/tools/buildbot/bin/python'} 05:55:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 05:55:42 INFO - mozversion application_buildid: 20161029030204 05:55:42 INFO - mozversion application_changeset: 1561c917ee27c3ea04bd69467e5b8c7c08102f2a 05:55:42 INFO - mozversion application_display_name: Nightly 05:55:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:55:42 INFO - mozversion application_name: Firefox 05:55:42 INFO - mozversion application_remotingname: firefox 05:55:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:55:42 INFO - mozversion application_vendor: Mozilla 05:55:42 INFO - mozversion application_version: 52.0a1 05:55:42 INFO - mozversion platform_buildid: 20161029030204 05:55:42 INFO - mozversion platform_changeset: 1561c917ee27c3ea04bd69467e5b8c7c08102f2a 05:55:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:55:42 INFO - mozversion platform_version: 52.0a1 05:55:42 INFO - using testdate: 1477745742 05:55:42 INFO - actual date: 1477745742 05:55:42 INFO - starting webserver on 'localhost:50497' 05:55:42 INFO - SUITE-START | Running 2 tests 05:55:42 INFO - TEST-START | dromaeo_css 05:55:42 INFO - operating with platform_type : linux_ 05:55:42 INFO - Initialising browser for dromaeo_css test... 05:55:42 INFO - TEST-INFO | started process 6209 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1bmf9f/profile http://localhost:50497/getInfo.html) 05:55:46 INFO - PROCESS | 6209 | __metrics Screen width/height:1600/1200 05:55:46 INFO - PROCESS | 6209 | colorDepth:24 05:55:46 INFO - PROCESS | 6209 | Browser inner width/height: 1024/697 05:55:46 INFO - PROCESS | 6209 | __metrics 05:55:47 INFO - PROCESS | 6209 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:55:47 INFO - PROCESS | 6209 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:55:48 INFO - PROCESS | 6209 | console.error: PushService: 05:55:48 INFO - PROCESS | 6209 | stateChangeProcessEnqueue: Error transitioning state 05:55:48 INFO - PROCESS | 6209 | UnknownError 05:55:48 INFO - TEST-INFO | 6209: exit 0 05:55:48 INFO - Browser initialized. 05:55:48 INFO - Running cycle 1/1 for dromaeo_css test... 05:55:48 INFO - TEST-INFO | started process 6293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1bmf9f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:56:00 INFO - PROCESS | 6293 | RSS: Main: 171483136 05:56:00 INFO - PROCESS | 6293 | 05:56:51 INFO - PROCESS | 6293 | 1477745811546 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] 05:59:03 INFO - PROCESS | 6293 | Cycle 1(1): loaded http://localhost:50497/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50497/tests/dromaeo/cssquery-ext.html) 05:59:04 INFO - PROCESS | 6293 | RSS: Main: 330420224 05:59:04 INFO - PROCESS | 6293 | 06:02:07 INFO - PROCESS | 6293 | Cycle 1(1): loaded http://localhost:50497/tests/dromaeo/cssquery-ext.html (next: http://localhost:50497/tests/dromaeo/cssquery-jquery.html) 06:02:07 INFO - PROCESS | 6293 | RSS: Main: 279195648 06:02:07 INFO - PROCESS | 6293 | 06:05:09 INFO - PROCESS | 6293 | Cycle 1(1): loaded http://localhost:50497/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50497/tests/dromaeo/cssquery-mootools.html) 06:05:10 INFO - PROCESS | 6293 | RSS: Main: 213532672 06:05:10 INFO - PROCESS | 6293 | 06:08:12 INFO - PROCESS | 6293 | Cycle 1(1): loaded http://localhost:50497/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50497/tests/dromaeo/cssquery-prototype.html) 06:08:12 INFO - PROCESS | 6293 | RSS: Main: 259489792 06:08:12 INFO - PROCESS | 6293 | 06:11:15 INFO - PROCESS | 6293 | Cycle 1(1): loaded http://localhost:50497/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50497/tests/dromaeo/cssquery-yui.html) 06:11:16 INFO - PROCESS | 6293 | RSS: Main: 217006080 06:11:16 INFO - PROCESS | 6293 | 06:14:19 INFO - PROCESS | 6293 | Cycle 1(1): loaded http://localhost:50497/tests/dromaeo/cssquery-yui.html (next: http://localhost:50497/tests/dromaeo/cssquery-dojo.html) 06:14:19 INFO - PROCESS | 6293 | RSS: Main: 307843072 06:14:19 INFO - PROCESS | 6293 | 06:14:19 INFO - PROCESS | 6293 | __start_tp_report 06:14:19 INFO - PROCESS | 6293 | _x_x_mozilla_page_load 06:14:19 INFO - PROCESS | 6293 | _x_x_mozilla_page_load_details 06:14:19 INFO - PROCESS | 6293 | |i|pagename|runs| 06:14:19 INFO - PROCESS | 6293 | |0;dojo.html;2985.9999999999995;3047.588575542301;3052.4810782167037;3077.0461157041304;3100.7519398448126;5202.973985130078;5237.607179461546;5242.21366794981;5323.547498462631;5333.466653334669;5279.788808447667;5295.205719142131;5307.2569840222395;5307.363116426025;5308.124159513685;4825.227963525827;4860.927086093711;4873.805047798084;4912.48418916014;4912.950870491285;4788.449328327252;4838.491958344376;4862.29496722975;4881.926771098437;4917.926231106536;4871.488493708162;4904;4928.507149285078;4967.528084831935;4980.05378977993;481.7789130001106;4904.411470623512;4912.508749125094;4928.125265254985;4975.975120124376;3424.6159016879974;4656.41794775653;4681.765911704401;4688.5077066907825;4878.926816097762;5284.682919024871;5293.920591191135;5294.047071527124;5295.152775555931;5309.283246761715;5586.190002449663;5695.686737229451;5721.513671337942;5721.7711291548285;5792.391798861143;5569.192467092289;5580.135079062752;5602.467765562265;5619.80330688424;5634.802781902655;5226.634135610509;5278.9208161877605;5290.841274761763;5292.338457692788;5293.179557168645;5810;5817.534597232211;5820.621659592113;5821.79623713168;5824.708764561755;5481.643693160012;5525.143602741581;5581.413951535112;5640.661560306313;5660.632058916157;5731.512821410143;5757.913631295534;5763.308402991668;5764.221830052889;5824.504917082011;5740.253767010346;5744.913826292609;5748.597598168171;5749.195112684228;5749.511291540266;5580.86047848807;5625.46558076982;5631.380548139701;5702.714864256771;5807.82576522705;4237.87286381409;4275.786210689453;4281.743095414286;4285.078708077778;4287.228298906227;3848.4034974578985;3852.614738526125;3864.246471937945;3882.495275614152;3885.669718073995;5406.270153529302;5407.70257635826;5415.377231618336;5417.133258678593;5417.512423881791;5701.173329867146;5739.368669446358;5749;5757.0788673811985;5759.884802304015;5340;5345.118055520873;5352.652077614943;5352.9732351338;5360.544353729899;4806.375171227718;4812.302216178635;4813.892804654949;4816.530958057756;4829.73436460991;5954.910676339859;5957.851053723605;5964.522838172936;5970.283565972111;5975.492083172979;5607.411221821813;5661.264035675335;5753.1945527627;5759.280089988752;5764.711764411679;5839.299284085937;5890.4993075587345;5906.232189815297;5933.347331793413;6015.849603759941;5635.577331700221;5654.660720356792;5654.915176272277;5659.236003139524;5663.348714897675;5546.916796247979;5738;5747.08046712524;5752.28096487939;5755.740991655469;5424.430434804289;5471.23402723627;5477.4248703887115;5500.889982200413;5540.695261760642;5523.364813046551;5529;5573.27547418833;5583.8883222336135;5593.188987596857;5500.092484740133;5503.559715222853;5512.062949298549;5517.282753242052;5520.033994051106;5450.890982180414;5513.8345849624575;5537;5554.416786237387;5563.860903477445;5439.755211015593;5478.150886612581;5479.424660410599;5511.58663100261;5527.281453411031 06:14:19 INFO - PROCESS | 6293 | |1;ext.html;552.2737600055926;598.4434475937378;610.2890132995058;617.1945610977672;617.5245061302795;30347.848260758692;33121.33757324852;33207.16982075446;33211.66788332116;33212.66787332126;34469.82765086177;43070;43917.12165756683;44044.33933490992;47948;8808.91191088089;8920.286377089817;8931.50876701781;8936.285097192242;8941.284697224206;8792.032876383593;8877;8884.644614215424;8891.510966896818;8893.244074253696;8046.758597242063;8236.62935167916;10462.215333849954;10705.411202383866;10737.194710396712;10680.359178449318;10685.519151638116;10740.570377184904;10753.354798712064;10759.677209683721;10615.946920265427;10685.252032357737;10691.358518488916;10693.78612427747;10697.304675196086;41561;41804.58195418037;41827;41881.79059104715;41886.1622767546;3377.3751855906735;3465.462853257749;3569.607343192247;3610.7472476926628;3623.710103191738;30773.692263077308;31017.844910775526;31239.06282811519;33260.168495787555;33345;4124.711270211086;4211.642010429086;4280.614744672995;4341.088371442001;4463.129689710508;331352;331652;333201;333644;334627.99999999756;59047;59163;59469.405305946384;59474;59627.403725962184;62775.03637154463;62818.68590657017;62861.68569157125;62967.6851615739;62997.37002629915;15829.445969391016;16046.67906641884;16053.839461605468;16055.759163612554;16139.596510087107;11659.825102623467;11662.300261984308;11662.300261984308;11668.824967625493;11670.766584668429;16594.419195328104;17068.317267309416;18140.47449422744;19165.32921347774;19419.514512137026;6567.211934567787;6914.343137401939;7065.4700897432895;7126.790694884602;7201.495895287279;956.7464621875208;996.6362277768562;1012.4330374990029;1060.151878497199;1135.840982262484;30569.69430305713;30963.535546966814;31143.68856311408;31716.841415792773;31772.20569485735;1087.141158484804;1101.9504122314515;1112.1436493899653;1155.7052951497315;1185.6087491127907;15832.366705331888;16652.417165399394;16724.163791810603;16742.83257167437;16802.327906883587;490524;491601;493273;495017;495818;47659;49206.30952678563;55327.44672553303;55961;57203.42796571981;1335.826342575459;1357.511295933463;1361.598328493097;1365.5630198336437;1374.223563686514;30159.157542033183;32635;32644.34711305808;33074.17314567155;33277.83361083179;49162;52068.479315206365;54219;54219.45780542144;58842;462578;466657;466860;467732;467882.2847086078;41265;42156;42384.576154239294;42430.5756942439;42934.35598465963;45743.54256457526;46372.7681361591;46490.30264545967;46523.53476465192;49873.755680993716;39882.40176397414;39893.40159897662;40616;40618.59381406266;41997.1600567993;39594.80202598969;39809.80095099506;39830.2033959325;40541.79729101453;40737.59262407457;40003.19985600713;40458.79770601246;41260.38109428421;41483.585164147975;41508;31922.20194495156;35391.646083538835;35944;36394.8180259097;36517.26965460623;27200;27624.303868342027;27716.722832771415;27974.300642483286;28121.71878281191 06:14:19 INFO - PROCESS | 6293 | |2;jquery.html;359.6709011254702;365.444524323029;380.6060727147403;382.93270900090266;410.5237924008151;14123.929380353096;17950;18810.43568692938;19095.33166339175;20157.899210503925;18191.363302284422;18997.715034274497;19002.42992710221;19229.90385048076;19239.13423895928;5483.506484416402;5764.16419619157;5770.913436298438;5772.480476757091;5773.624714393551;4087.409982617333;4269.7224680395675;5711.7715291388295;5806.361300256968;6512.641804700739;6488.805335839932;6492.285848556655;6500.869982600345;6507.05647681086;6523.249826269992;6418.101465794793;6511;6590.604563726191;6600.80197594073;6603.514209302893;5760.36635970043;5767.134929760569;5791.160281759121;5802.912956305659;5803.274590676166;21660;21793.782062179333;21812.345629631138;21894.23370182036;22018.78896660683;2280.407094155515;2330.34750269923;2376.7860892519757;2443.438009257881;2518.1941778630844;14002.439902403892;15497.45758898433;15820.288087036111;16021.679566408724;16757.49727508177;2026.2401599400225;2027.638765906218;2039.350281358505;2110.134844713675;2121.844242095354;81520.59239703823;87136;91368;93861.5306923461;93883.53058234733;16565.751513727304;16904.746428803577;17108.657826843395;17221.56946076358;17441.215145318238;31446;31466.685333146375;31658.841705791783;31734.68265317317;32001.19997000047;9017.549122543847;9248.306377021616;9257.259419246444;9457.668981585612;9529.380590261611;7599.658015389321;7631.656575454007;7667.846643067108;7869;7927.960360198162;8626.309895208367;8697.565121743888;8762.283692055484;8914.974777900625;8986.370954033286;3075.7693173012112;3251.7398608111293;3255.3326568053494;3455.87904423344;3492.7031202348085;853.6884037326331;952.518977916148;956.3735753081743;971.0338213477635;996.1881066930429;19326;19785.901070494554;19869.30457433983;20107.698384524243;20138;949.6106596295485;976.9706908792748;984.3011461862015;993.3493561716942;998.1565577087349;10869.728256793485;10999.670009899715;11084.279521831055;11086.667399978014;11103.666889993314;328615;334349;335628;430963;434095;94969.5251523738;97880;98234;99695;101362.49318753359;1023.2070145637042;1054.8312270036756;1076.3972175581544;1083.3878858444953;1086.5219303506433;12951.481940722266;16365.918170409548;16536.917315413346;17616;18113.275468981094;38798.04640048727;39854.60145398509;39975.400368993905;42418.57581424146;44733.329000064376;53613.83440904346;53848.46151538435;56517;56865.71567142138;58287.70856145692;6295.905561416491;8165.755027349189;8166.265036146775;8372.330213582776;8655.783605409915;12037.879621204027;13374.13068150567;13406.597802065953;13575.253361065235;13586.932065340005;11379.54481820751;11520.078393728649;11602.18784685064;12098;12165.600955890186;11505.539778409106;11541.134414919083;11580.478878450322;11732.472038758106;11872.347020913932;10868.293560918515;11378.203525753448;11396.715082122682;11829.940850295694;12220.75558488843;8359.916400835913;8364.66541338364;8477.61850716707;8522.147785221428;8550.187732165434;11450.828237576276;11578.94210528942;11662.067034637039;11676.357800321064;12097.274163550215 06:14:19 INFO - PROCESS | 6293 | |3;mootools.html;1427.4004917934467;1458.030409777498;1573.843225229456;1728.2654871679533;1767.5316041249064;7510.361619262356;7763.883541746878;8081.676732930676;8621.008584012841;8621.439606425585;7984.520928744279;8288.627011784469;8326.458780179299;8544.829103417927;8549.61526731297;2088.945082733221;2101.359085478928;2117.8093971542557;2121.586290673319;2122.2253877334815;1905.990470047648;1972.437855211265;2110.662294032955;2155.8706477611313;2195.3633446300555;1938.6704260275787;1939.6508628446875;1959.804019598043;2008.8895110768901;2107.9367618971455;2096.3920463065692;2097.2345094040716;2098.58028394321;2099.0449345547813;2110.303599812058;2092.612866619665;2094.3507512670967;2098.475381154711;2136.1028368085285;2142.967855482169;7815.843683126305;7860.567668778215;7923.762287131395;7933.603319834043;7934.603269836485;5028.899422011576;5169.56058735008;5178.870528236786;5188.948110518922;5191.636585439021;3021.2748940254182;3195.328980914011;3215.887443939451;3233.757468189872;3260.5761251037216;963.4412041016263;1005.7284533176074;1010.2927950434652;1038.6468600675807;1047.8742550893865;11899.405029748477;11928.224665396721;11937.701557461047;11939.283642981449;11958.282503049844;4303.311470164758;4506.7070640408265;4577.610903073276;4611.677182597186;4616.60758835496;9971.40171589707;9975.800483990279;9994.250431217688;10001.399916005063;10006.849897251546;5253.789848406097;5259.526642602108;5259.605529585297;5264.315638966987;5266.236395722599;4683.344331793552;4794.688345257547;4828.396450443694;4846.854594362175;4847.830325938575;3621.6740493355724;3644.653757892996;3731;3739.1586892948867;3753.3619284721663;1216.2398500936915;1223.614561413152;1231.445849367788;1237.4864431260926;1249.3503378243445;793.8729803231455;902.6208992223281;930.7393929699695;948.3346864369164;980.5587485631495;5640.8871822563315;5705.942940570624;5709.68596727184;5710.200571919934;5814.9709251454315;909.713440266314;946.7680418297424;955.102203928319;960.9855852162223;961.2838435365697;3849.9037524061564;3905.7461265017682;3906.257811015898;3989.6209860063245;4000.6199411055904;10288.845667314847;10557;10650.254482186327;10667.039966403061;10693.679189624323;10322.277440579088;10423.791524169474;10610.522526486327;10617.946910265398;10636.361818290927;7987.800304992422;8043.557604331818;8193.918060819435;8208.958955205186;8217.178282171855;5338.172583249602;5488.17677348401;5588.105903055492;5623.3814280428305;5648.745806438638;9728.22174226046;9801.607935682492;9822.607095716092;9862.753431164278;9865.45739984279;9741.756456088655;9856.753581160528;9958.203343732628;10024.047715467019;10070.44612546317;6856.965715171392;6963.199232088172;6984;6991.475639327173;6994.2306346302885;7905.723299684483;7938.64276107565;7974.481658692166;7981.680732770624;7982.1618730032515;7223.783286501413;7331.3768329692575;7365.7790266292095;7382.5939573323985;7385.409167266498;7126.679299431435;7191.316824901626;7240;7313.744018959311;7334.486585939147;6434.517411194086;6548.246951600627;6559.770408035696;6564.934350656432;6571.474282057328;5005.224190250517;5058.570021548209;5067;5123.103456895103;5285.735713214401;5058.747062646779;5075.3402057732255;5104.846854594368;5121.8719532012;5272.7100009499845 06:14:19 INFO - PROCESS | 6293 | |4;prototype.html;304.9451098802215;320.99528475870505;326.7745255773516;329.68515068109957;329.9606240342921;5027.62292828038;5121.129408000639;5184.792608295664;5212.322398088253;5233.921491177635;4939.8024079036795;5142.511461411169;5147.794088236476;5148.279240906276;5153.037003722856;4042.2521833460755;4047.433359329696;4060.451839001741;4070.4708387909677;4080.1431699343025;3920.176762879799;4028.838846446153;4031.21391328691;4039.515258169024;4089.7750623715683;3954.4463775071367;3964.9801750991205;3993.700472464562;3996.2216813518;4006.198760247962;3970.4639873617125;3973.9071755267387;4022.1955608878343;4037.2329257440992;4061.614146656063;3414.778039427429;3544.805035723034;3559.94660080099;3560.9168636347767;3562.69717074049;5043.9747801260755;5047.889464317845;5056.570191533724;5060;5060.49395060491;4513.1650644630845;4537.705049171826;4555.362249285103;4577.816887324537;4596.632269418472;5140.3831540215415;5371.489708477728;5374.140137577969;5395.541378982791;5398.703071331075;3836.9808150959348;3863.555691095532;3869.2454971280613;3877.5346958364894;3884.184321292532;5587.497125258706;5611.270534830527;5611.9438805612235;5615.2700148980375;5623.0721930881355;3932.4494570760116;3967;3971.801409929492;3974.3307810719566;3975.920481590352;3833.884983450501;3956.2878681837547;3991.8802435926386;4003.2794097062224;4010.3783913493453;4326.6754993375625;4422.71252368595;4476.843310484118;4567.611753000966;4573.931391029138;5445.6385903524115;5450.048714681903;5456.372517160498;5468.781248750085;5472.534834539029;1312.252016350671;1339.430741934674;1361.0200655528004;1364.8498665146826;1381.2886363522794;913.9862902056475;935.3919952031234;943.1982814607529;945.1493655709779;950.2255661635745;5267.209918512177;5268.947310526923;5272.367315922113;5308.893822123536;5331.173668081454;5474.494514008679;5547.944520554743;5593.608447408724;5600.411956744565;5619.522340601013;5186.429492755794;5210.531052205244;5210.76551555181;5230.320058392384;5236.869078273074;2584.754448327406;2595.6120369260325;2603.7266087060966;2605.830621009666;2610.2430295214554;4799.616030717534;4990.301357809837;5020.397552293748;5051.696898186121;5063.594912406998;4926.275803468758;4944.703317800943;4949.7030178189425;4956.256561515802;4982.651214415028;4997.4512998370365;5030.547250747451;5036.952643650612;5043.5965122790085;5060.468650791688;4878.56092951636;4897.681650692836;5262.736863156903;5606.915896261477;5635.295588051494;5551.666899986014;5574.609777315549;5579.218909352775;5585.525230355465;5594.832155035356;5652.3217213934595;5802.564807639359;5834.15404766315;5834.854128646648;5868.589198756046;3943.467631869661;3948;3960.702947278908;3989.7805620691142;4013.8996525087105;5413.566914646897;5513.3108361454815;5515.641483303572;5632.549396048388;5641.9435805641415;5426.891462170655;5427.864303392446;5434.945650543444;5467.945320546903;5477.589860461543;5205.553389906738;5385.299911011543;5407.459254074561;5426.565874729933;5431.158170483582;5336.653117547347;5358.892822143614;5378.704171270618;5382.19267109921;5382.946170538245;5413.729313534386;5440.319960004999;5477.4248703887115;5558.471945165203;5564.415736347625;5146.908207974744;5287.7620507078045;5314.22943673173;5390.730463476889;5391.2235198873395 06:14:19 INFO - PROCESS | 6293 | |5;yui.html;739.8224426137726;756.6670664907442;757.0839284465796;777.6228529163351;791.5132193700875;14284.857151428483;14328;14650.70698586029;15314;15435.305411256506;13415.932920335408;13443.731125377486;13623.523176688794;13673.179609223429;13714.108582942103;669.357416879796;765.7855800375904;779.372605052935;779.95710235937;780.5160800303792;685.3763075601204;809.5709274084744;821.109096630157;824.3281725393815;826.8304997475533;850.124371896944;855.2516548020482;855.5850412549909;857.2413414128509;857.2841677199546;686.5228666077079;844.0293662288356;844.5523872347604;845.4335595151264;846.0270688707974;514.8172398798448;611.6574718157846;627.5387590121258;628.2178687534004;632.2223664892163;14107.506237281646;14148.717025659429;14151;14151.787723184161;14157.716845663132;12657.367131643474;12785.488580456771;13168.341582920815;13710.52013179544;13719.45122195111;11578.53685852565;11600.053828555992;11638.1271404645;11826;11914.225575337576;4175.394567787654;4190.329547272452;4229.619334259901;4239.3217085266515;4295.162443323553;59698.70150649262;60470;60596.69701651508;61530.69234653843;64307;10168.881782751956;10327.793444131226;10443.791124177626;10528.789424211473;10608;18750;18846.43460696181;18979.525511862314;18990.24039038423;19261.711074333896;7709.42179336552;7770.261825126604;7817.8827317590285;7824;7847.293743563107;4423.712458690175;4444.355568442623;4451.265541185668;4525.366448697185;4534.523874993144;3181.4750566156786;3292.703656670911;3294.769366144395;3302.256992176741;3307.570015897918;588.3763210996358;606.1756011823916;624.7875722254455;627.212847875922;629.902365133405;720.9222212791805;729.3946024799404;730.9707611695472;777.6461709921972;797.6849144587856;9524.666636667684;9558.330916835755;9707.854382184272;9778.804423911482;9788.951055244679;677.5799004617169;678.955867868587;738.2801768275996;746.1046743907333;751.1136858507015;4213.5154457237195;4369.541198174209;4451.399061126771;4476.977615111969;4675.392199014106;67982.66008669925;69141.96287055698;69957;78283.21716782759;86949.56525217333;43668.563314367086;44192.55807441884;54556.727216363666;69710.65144674244;69901.65049174824;39157.80421097933;55617;62208.68895655493;63108;66720;9156.816863662556;9297.349185556946;9434.858477122985;9603.135717785433;9726.951365243129;32892.83553582313;42990.14019719526;43286.35070473883;43765.12469750651;44622.55377446314;52114.73942630263;59183.408165919514;61761.382386175566;61894.38105618886;62290.37709623027;12176.747301749205;12218.572349968064;12442.502299907903;12447.253164810141;13035.934820325838;13521.391537381038;13621;13687.45250190021;13823.377947992163;14660.413583456542;12562.560310389457;12609.684757881127;12927.5475358362;12943.158694684815;13303.866961330263;12175.029740720476;12507.37755734656;12695;13086.541971030969;13102.344882756015;12573.861964765705;12618.55835045769;12975.545855894998;13298.401571929093;13659.521916732867;10567;10641.787164256517;10690.572377104829;10972.945135274273;10987.945060274647;10209.846852297072;10406.427646479517;10677.51951162184;10746.753408485272;10990.230683852373 06:14:19 INFO - PROCESS | 6293 | __end_tp_report 06:14:19 INFO - PROCESS | 6293 | __start_cc_report 06:14:19 INFO - PROCESS | 6293 | _x_x_mozilla_cycle_collect,1435 06:14:19 INFO - PROCESS | 6293 | __end_cc_report 06:14:19 INFO - PROCESS | 6293 | __startTimestamp1477746859306__endTimestamp 06:14:19 INFO - PROCESS | 6293 | 06:14:19 INFO - PROCESS | 6293 | ------- Summary: start ------- 06:14:19 INFO - PROCESS | 6293 | Number of tests: 6 06:14:19 INFO - PROCESS | 6293 | 06:14:19 INFO - PROCESS | 6293 | [#0] dojo.html Cycles:165 Average:5249.33 Median:5481.64 stddev:729.82 (13.3%) stddev-sans-first:710.13 06:14:19 INFO - PROCESS | 6293 | Values: 2986.0 3047.6 3052.5 3077.0 3100.8 5203.0 5237.6 5242.2 5323.5 5333.5 5279.8 5295.2 5307.3 5307.4 5308.1 4825.2 4860.9 4873.8 4912.5 4913.0 4788.4 4838.5 4862.3 4881.9 4917.9 4871.5 4904.0 4928.5 4967.5 4980.1 481.8 4904.4 4912.5 4928.1 4976.0 3424.6 4656.4 4681.8 4688.5 4878.9 5284.7 5293.9 5294.0 5295.2 5309.3 5586.2 5695.7 5721.5 5721.8 5792.4 5569.2 5580.1 5602.5 5619.8 5634.8 5226.6 5278.9 5290.8 5292.3 5293.2 5810.0 5817.5 5820.6 5821.8 5824.7 5481.6 5525.1 5581.4 5640.7 5660.6 5731.5 5757.9 5763.3 5764.2 5824.5 5740.3 5744.9 5748.6 5749.2 5749.5 5580.9 5625.5 5631.4 5702.7 5807.8 4237.9 4275.8 4281.7 4285.1 4287.2 3848.4 3852.6 3864.2 3882.5 3885.7 5406.3 5407.7 5415.4 5417.1 5417.5 5701.2 5739.4 5749.0 5757.1 5759.9 5340.0 5345.1 5352.7 5353.0 5360.5 4806.4 4812.3 4813.9 4816.5 4829.7 5954.9 5957.9 5964.5 5970.3 5975.5 5607.4 5661.3 5753.2 5759.3 5764.7 5839.3 5890.5 5906.2 5933.3 6015.8 5635.6 5654.7 5654.9 5659.2 5663.3 5546.9 5738.0 5747.1 5752.3 5755.7 5424.4 5471.2 5477.4 5500.9 5540.7 5523.4 5529.0 5573.3 5583.9 5593.2 5500.1 5503.6 5512.1 5517.3 5520.0 5450.9 5513.8 5537.0 5554.4 5563.9 5439.8 5478.2 5479.4 5511.6 5527.3 06:14:19 INFO - PROCESS | 6293 | 06:14:19 INFO - PROCESS | 6293 | [#1] ext.html Cycles:180 Average:59388.92 Median:39887.90 stddev:115553.92 (289.7%) stddev-sans-first:115793.64 06:14:19 INFO - PROCESS | 6293 | Values: 552.3 598.4 610.3 617.2 617.5 30347.8 33121.3 33207.2 33211.7 33212.7 34469.8 43070.0 43917.1 44044.3 47948.0 8808.9 8920.3 8931.5 8936.3 8941.3 8792.0 8877.0 8884.6 8891.5 8893.2 8046.8 8236.6 10462.2 10705.4 10737.2 10680.4 10685.5 10740.6 10753.4 10759.7 10615.9 10685.3 10691.4 10693.8 10697.3 41561.0 41804.6 41827.0 41881.8 41886.2 3377.4 3465.5 3569.6 3610.7 3623.7 30773.7 31017.8 31239.1 33260.2 33345.0 4124.7 4211.6 4280.6 4341.1 4463.1 331352.0 331652.0 333201.0 333644.0 334628.0 59047.0 59163.0 59469.4 59474.0 59627.4 62775.0 62818.7 62861.7 62967.7 62997.4 15829.4 16046.7 16053.8 16055.8 16139.6 11659.8 11662.3 11662.3 11668.8 11670.8 16594.4 17068.3 18140.5 19165.3 19419.5 6567.2 6914.3 7065.5 7126.8 7201.5 956.7 996.6 1012.4 1060.2 1135.8 30569.7 30963.5 31143.7 31716.8 31772.2 1087.1 1102.0 1112.1 1155.7 1185.6 15832.4 16652.4 16724.2 16742.8 16802.3 490524.0 491601.0 493273.0 495017.0 495818.0 47659.0 49206.3 55327.4 55961.0 57203.4 1335.8 1357.5 1361.6 1365.6 1374.2 30159.2 32635.0 32644.3 33074.2 33277.8 49162.0 52068.5 54219.0 54219.5 58842.0 462578.0 466657.0 466860.0 467732.0 467882.3 41265.0 42156.0 42384.6 42430.6 42934.4 45743.5 46372.8 46490.3 46523.5 49873.8 39882.4 39893.4 40616.0 40618.6 41997.2 39594.8 39809.8 39830.2 40541.8 40737.6 40003.2 40458.8 41260.4 41483.6 41508.0 31922.2 35391.6 35944.0 36394.8 36517.3 27200.0 27624.3 27716.7 27974.3 28121.7 06:14:19 INFO - PROCESS | 6293 | 06:14:19 INFO - PROCESS | 6293 | [#2] jquery.html Cycles:180 Average:26972.73 Median:334988.50 stddev:63079.60 (18.8%) stddev-sans-first:63224.91 06:14:19 INFO - PROCESS | 6293 | Values: 359.7 365.4 380.6 382.9 410.5 14123.9 17950.0 18810.4 19095.3 20157.9 18191.4 18997.7 19002.4 19229.9 19239.1 5483.5 5764.2 5770.9 5772.5 5773.6 4087.4 4269.7 5711.8 5806.4 6512.6 6488.8 6492.3 6500.9 6507.1 6523.2 6418.1 6511.0 6590.6 6600.8 6603.5 5760.4 5767.1 5791.2 5802.9 5803.3 21660.0 21793.8 21812.3 21894.2 22018.8 2280.4 2330.3 2376.8 2443.4 2518.2 14002.4 15497.5 15820.3 16021.7 16757.5 2026.2 2027.6 2039.4 2110.1 2121.8 81520.6 87136.0 91368.0 93861.5 93883.5 16565.8 16904.7 17108.7 17221.6 17441.2 31446.0 31466.7 31658.8 31734.7 32001.2 9017.5 9248.3 9257.3 9457.7 9529.4 7599.7 7631.7 7667.8 7869.0 7928.0 8626.3 8697.6 8762.3 8915.0 8986.4 3075.8 3251.7 3255.3 3455.9 3492.7 853.7 952.5 956.4 971.0 996.2 19326.0 19785.9 19869.3 20107.7 20138.0 949.6 977.0 984.3 993.3 998.2 10869.7 10999.7 11084.3 11086.7 11103.7 328615.0 334349.0 335628.0 430963.0 434095.0 94969.5 97880.0 98234.0 99695.0 101362.5 1023.2 1054.8 1076.4 1083.4 1086.5 12951.5 16365.9 16536.9 17616.0 18113.3 38798.0 39854.6 39975.4 42418.6 44733.3 53613.8 53848.5 56517.0 56865.7 58287.7 6295.9 8165.8 8166.3 8372.3 8655.8 12037.9 13374.1 13406.6 13575.3 13586.9 11379.5 11520.1 11602.2 12098.0 12165.6 11505.5 11541.1 11580.5 11732.5 11872.3 10868.3 11378.2 11396.7 11829.9 12220.8 8359.9 8364.7 8477.6 8522.1 8550.2 11450.8 11578.9 11662.1 11676.4 12097.3 06:14:19 INFO - PROCESS | 6293 | 06:14:19 INFO - PROCESS | 6293 | [#3] mootools.html Cycles:180 Average:5538.57 Median:5122.49 stddev:3177.21 (62.0%) stddev-sans-first:3171.10 06:14:19 INFO - PROCESS | 6293 | Values: 1427.4 1458.0 1573.8 1728.3 1767.5 7510.4 7763.9 8081.7 8621.0 8621.4 7984.5 8288.6 8326.5 8544.8 8549.6 2088.9 2101.4 2117.8 2121.6 2122.2 1906.0 1972.4 2110.7 2155.9 2195.4 1938.7 1939.7 1959.8 2008.9 2107.9 2096.4 2097.2 2098.6 2099.0 2110.3 2092.6 2094.4 2098.5 2136.1 2143.0 7815.8 7860.6 7923.8 7933.6 7934.6 5028.9 5169.6 5178.9 5188.9 5191.6 3021.3 3195.3 3215.9 3233.8 3260.6 963.4 1005.7 1010.3 1038.6 1047.9 11899.4 11928.2 11937.7 11939.3 11958.3 4303.3 4506.7 4577.6 4611.7 4616.6 9971.4 9975.8 9994.3 10001.4 10006.8 5253.8 5259.5 5259.6 5264.3 5266.2 4683.3 4794.7 4828.4 4846.9 4847.8 3621.7 3644.7 3731.0 3739.2 3753.4 1216.2 1223.6 1231.4 1237.5 1249.4 793.9 902.6 930.7 948.3 980.6 5640.9 5705.9 5709.7 5710.2 5815.0 909.7 946.8 955.1 961.0 961.3 3849.9 3905.7 3906.3 3989.6 4000.6 10288.8 10557.0 10650.3 10667.0 10693.7 10322.3 10423.8 10610.5 10617.9 10636.4 7987.8 8043.6 8193.9 8209.0 8217.2 5338.2 5488.2 5588.1 5623.4 5648.7 9728.2 9801.6 9822.6 9862.8 9865.5 9741.8 9856.8 9958.2 10024.0 10070.4 6857.0 6963.2 6984.0 6991.5 6994.2 7905.7 7938.6 7974.5 7981.7 7982.2 7223.8 7331.4 7365.8 7382.6 7385.4 7126.7 7191.3 7240.0 7313.7 7334.5 6434.5 6548.2 6559.8 6564.9 6571.5 5005.2 5058.6 5067.0 5123.1 5285.7 5058.7 5075.3 5104.8 5121.9 5272.7 06:14:19 INFO - PROCESS | 6293 | 06:14:19 INFO - PROCESS | 6293 | [#4] prototype.html Cycles:180 Average:4486.98 Median:5060.23 stddev:1321.22 (26.1%) stddev-sans-first:1287.10 06:14:19 INFO - PROCESS | 6293 | Values: 304.9 321.0 326.8 329.7 330.0 5027.6 5121.1 5184.8 5212.3 5233.9 4939.8 5142.5 5147.8 5148.3 5153.0 4042.3 4047.4 4060.5 4070.5 4080.1 3920.2 4028.8 4031.2 4039.5 4089.8 3954.4 3965.0 3993.7 3996.2 4006.2 3970.5 3973.9 4022.2 4037.2 4061.6 3414.8 3544.8 3559.9 3560.9 3562.7 5044.0 5047.9 5056.6 5060.0 5060.5 4513.2 4537.7 4555.4 4577.8 4596.6 5140.4 5371.5 5374.1 5395.5 5398.7 3837.0 3863.6 3869.2 3877.5 3884.2 5587.5 5611.3 5611.9 5615.3 5623.1 3932.4 3967.0 3971.8 3974.3 3975.9 3833.9 3956.3 3991.9 4003.3 4010.4 4326.7 4422.7 4476.8 4567.6 4573.9 5445.6 5450.0 5456.4 5468.8 5472.5 1312.3 1339.4 1361.0 1364.8 1381.3 914.0 935.4 943.2 945.1 950.2 5267.2 5268.9 5272.4 5308.9 5331.2 5474.5 5547.9 5593.6 5600.4 5619.5 5186.4 5210.5 5210.8 5230.3 5236.9 2584.8 2595.6 2603.7 2605.8 2610.2 4799.6 4990.3 5020.4 5051.7 5063.6 4926.3 4944.7 4949.7 4956.3 4982.7 4997.5 5030.5 5037.0 5043.6 5060.5 4878.6 4897.7 5262.7 5606.9 5635.3 5551.7 5574.6 5579.2 5585.5 5594.8 5652.3 5802.6 5834.2 5834.9 5868.6 3943.5 3948.0 3960.7 3989.8 4013.9 5413.6 5513.3 5515.6 5632.5 5641.9 5426.9 5427.9 5434.9 5467.9 5477.6 5205.6 5385.3 5407.5 5426.6 5431.2 5336.7 5358.9 5378.7 5382.2 5382.9 5413.7 5440.3 5477.4 5558.5 5564.4 5146.9 5287.8 5314.2 5390.7 5391.2 06:14:19 INFO - PROCESS | 6293 | 06:14:19 INFO - PROCESS | 6293 | [#5] yui.html Cycles:180 Average:16212.20 Median:4447.81 stddev:20239.77 (455.1%) stddev-sans-first:20263.20 06:14:19 INFO - PROCESS | 6293 | Values: 739.8 756.7 757.1 777.6 791.5 14284.9 14328.0 14650.7 15314.0 15435.3 13415.9 13443.7 13623.5 13673.2 13714.1 669.4 765.8 779.4 780.0 780.5 685.4 809.6 821.1 824.3 826.8 850.1 855.3 855.6 857.2 857.3 686.5 844.0 844.6 845.4 846.0 514.8 611.7 627.5 628.2 632.2 14107.5 14148.7 14151.0 14151.8 14157.7 12657.4 12785.5 13168.3 13710.5 13719.5 11578.5 11600.1 11638.1 11826.0 11914.2 4175.4 4190.3 4229.6 4239.3 4295.2 59698.7 60470.0 60596.7 61530.7 64307.0 10168.9 10327.8 10443.8 10528.8 10608.0 18750.0 18846.4 18979.5 18990.2 19261.7 7709.4 7770.3 7817.9 7824.0 7847.3 4423.7 4444.4 4451.3 4525.4 4534.5 3181.5 3292.7 3294.8 3302.3 3307.6 588.4 606.2 624.8 627.2 629.9 720.9 729.4 731.0 777.6 797.7 9524.7 9558.3 9707.9 9778.8 9789.0 677.6 679.0 738.3 746.1 751.1 4213.5 4369.5 4451.4 4477.0 4675.4 67982.7 69142.0 69957.0 78283.2 86949.6 43668.6 44192.6 54556.7 69710.7 69901.7 39157.8 55617.0 62208.7 63108.0 66720.0 9156.8 9297.3 9434.9 9603.1 9727.0 32892.8 42990.1 43286.4 43765.1 44622.6 52114.7 59183.4 61761.4 61894.4 62290.4 12176.7 12218.6 12442.5 12447.3 13035.9 13521.4 13621.0 13687.5 13823.4 14660.4 12562.6 12609.7 12927.5 12943.2 13303.9 12175.0 12507.4 12695.0 13086.5 13102.3 12573.9 12618.6 12975.5 13298.4 13659.5 10567.0 10641.8 10690.6 10972.9 10987.9 10209.8 10406.4 10677.5 10746.8 10990.2 06:14:19 INFO - PROCESS | 6293 | -------- Summary: end -------- 06:14:19 INFO - PROCESS | 6293 | 06:14:20 INFO - TEST-INFO | 6293: exit 0 06:14:20 INFO - TEST-OK | dromaeo_css | took 1117493ms 06:14:20 INFO - TEST-START | kraken 06:14:20 INFO - operating with platform_type : linux_ 06:14:20 INFO - Initialising browser for kraken test... 06:14:20 INFO - TEST-INFO | started process 6611 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTUhl56/profile http://localhost:50497/getInfo.html) 06:14:24 INFO - PROCESS | 6611 | __metrics Screen width/height:1600/1200 06:14:24 INFO - PROCESS | 6611 | colorDepth:24 06:14:24 INFO - PROCESS | 6611 | Browser inner width/height: 1024/697 06:14:24 INFO - PROCESS | 6611 | __metrics 06:14:24 INFO - PROCESS | 6611 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:14:24 INFO - PROCESS | 6611 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:14:25 INFO - PROCESS | 6611 | console.error: PushService: 06:14:25 INFO - PROCESS | 6611 | stateChangeProcessEnqueue: Error transitioning state 06:14:25 INFO - PROCESS | 6611 | UnknownError 06:14:26 INFO - TEST-INFO | 6611: exit 0 06:14:26 INFO - Browser initialized. 06:14:26 INFO - Running cycle 1/1 for kraken test... 06:14:26 INFO - TEST-INFO | started process 6694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTUhl56/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:14:38 INFO - PROCESS | 6694 | RSS: Main: 172314624 06:14:38 INFO - PROCESS | 6694 | 06:14:40 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50497/tests/kraken/driver.html?testName=audio-beat-detection) 06:14:41 INFO - PROCESS | 6694 | RSS: Main: 228835328 06:14:41 INFO - PROCESS | 6694 | 06:14:44 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50497/tests/kraken/driver.html?testName=audio-dft) 06:14:44 INFO - PROCESS | 6694 | RSS: Main: 216473600 06:14:44 INFO - PROCESS | 6694 | 06:14:47 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50497/tests/kraken/driver.html?testName=audio-fft) 06:14:48 INFO - PROCESS | 6694 | RSS: Main: 297857024 06:14:48 INFO - PROCESS | 6694 | 06:14:50 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50497/tests/kraken/driver.html?testName=audio-oscillator) 06:14:51 INFO - PROCESS | 6694 | RSS: Main: 208969728 06:14:51 INFO - PROCESS | 6694 | 06:14:53 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50497/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:14:54 INFO - PROCESS | 6694 | RSS: Main: 211767296 06:14:54 INFO - PROCESS | 6694 | 06:14:57 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50497/tests/kraken/driver.html?testName=imaging-darkroom) 06:14:57 INFO - PROCESS | 6694 | RSS: Main: 247619584 06:14:57 INFO - PROCESS | 6694 | 06:15:00 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50497/tests/kraken/driver.html?testName=imaging-desaturate) 06:15:01 INFO - PROCESS | 6694 | RSS: Main: 246231040 06:15:01 INFO - PROCESS | 6694 | 06:15:04 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50497/tests/kraken/driver.html?testName=json-parse-financial) 06:15:04 INFO - PROCESS | 6694 | RSS: Main: 246796288 06:15:04 INFO - PROCESS | 6694 | 06:15:06 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50497/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:15:06 INFO - PROCESS | 6694 | RSS: Main: 208826368 06:15:06 INFO - PROCESS | 6694 | 06:15:08 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50497/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:15:09 INFO - PROCESS | 6694 | RSS: Main: 216518656 06:15:09 INFO - PROCESS | 6694 | 06:15:11 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50497/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:15:11 INFO - PROCESS | 6694 | RSS: Main: 225644544 06:15:11 INFO - PROCESS | 6694 | 06:15:14 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50497/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:15:15 INFO - PROCESS | 6694 | RSS: Main: 234119168 06:15:15 INFO - PROCESS | 6694 | 06:15:18 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50497/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:15:18 INFO - PROCESS | 6694 | RSS: Main: 231149568 06:15:18 INFO - PROCESS | 6694 | 06:15:20 INFO - PROCESS | 6694 | Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50497/tests/kraken/driver.html?testName=ai-astar) 06:15:20 INFO - PROCESS | 6694 | RSS: Main: 281878528 06:15:20 INFO - PROCESS | 6694 | 06:15:20 INFO - PROCESS | 6694 | __start_tp_report 06:15:20 INFO - PROCESS | 6694 | _x_x_mozilla_page_load 06:15:20 INFO - PROCESS | 6694 | _x_x_mozilla_page_load_details 06:15:20 INFO - PROCESS | 6694 | |i|pagename|runs| 06:15:20 INFO - PROCESS | 6694 | |0;ai-astar;103;111;112;110;113;111;112;113;111;113 06:15:20 INFO - PROCESS | 6694 | |1;audio-beat-detection;154;123;126;168;123;125;129;121;153;121 06:15:20 INFO - PROCESS | 6694 | |2;audio-dft;161;162;161;160;161;161;159;161;160;163 06:15:20 INFO - PROCESS | 6694 | |3;audio-fft;75;77;75;115;76;76;76;76;107;80 06:15:20 INFO - PROCESS | 6694 | |4;audio-oscillator;83;82;116;81;82;82;122;82;83;107 06:15:20 INFO - PROCESS | 6694 | |5;imaging-gaussian-blur;118;118;117;117;117;118;118;117;118;118 06:15:20 INFO - PROCESS | 6694 | |6;imaging-darkroom;146;145;146;147;147;146;145;145;146;146 06:15:20 INFO - PROCESS | 6694 | |7;imaging-desaturate;84;84;86;85;84;84;85;84;84;85 06:15:20 INFO - PROCESS | 6694 | |8;json-parse-financial;54;51;52;53;52;53;53;53;54;53 06:15:20 INFO - PROCESS | 6694 | |9;json-stringify-tinderbox;61;62;62;63;63;62;62;62;62;62 06:15:20 INFO - PROCESS | 6694 | |10;stanford-crypto-aes;88;79;87;79;82;85;80;87;79;79 06:15:20 INFO - PROCESS | 6694 | |11;stanford-crypto-ccm;140;129;134;135;133;136;129;138;175;128 06:15:20 INFO - PROCESS | 6694 | |12;stanford-crypto-pbkdf2;167;167;167;164;170;167;166;165;165;168 06:15:20 INFO - PROCESS | 6694 | |13;stanford-crypto-sha256-iterative;69;66;65;69;67;67;70;66;64;70 06:15:20 INFO - PROCESS | 6694 | __end_tp_report 06:15:20 INFO - PROCESS | 6694 | __start_cc_report 06:15:20 INFO - PROCESS | 6694 | _x_x_mozilla_cycle_collect,1720 06:15:20 INFO - PROCESS | 6694 | __end_cc_report 06:15:20 INFO - PROCESS | 6694 | __startTimestamp1477746920562__endTimestamp 06:15:20 INFO - PROCESS | 6694 | 06:15:20 INFO - PROCESS | 6694 | ------- Summary: start ------- 06:15:20 INFO - PROCESS | 6694 | Number of tests: 14 06:15:20 INFO - PROCESS | 6694 | 06:15:20 INFO - PROCESS | 6694 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:2.96 (2.6%) stddev-sans-first:1.09 06:15:20 INFO - PROCESS | 6694 | Values: 103.0 111.0 112.0 110.0 113.0 111.0 112.0 113.0 111.0 113.0 06:15:20 INFO - PROCESS | 6694 | 06:15:20 INFO - PROCESS | 6694 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:127.50 stddev:17.21 (13.5%) stddev-sans-first:16.71 06:15:20 INFO - PROCESS | 6694 | Values: 154.0 123.0 126.0 168.0 123.0 125.0 129.0 121.0 153.0 121.0 06:15:20 INFO - PROCESS | 6694 | 06:15:20 INFO - PROCESS | 6694 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 06:15:20 INFO - PROCESS | 6694 | Values: 161.0 162.0 161.0 160.0 161.0 161.0 159.0 161.0 160.0 163.0 06:15:20 INFO - PROCESS | 6694 | 06:15:20 INFO - PROCESS | 6694 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:14.79 (19.5%) stddev-sans-first:15.38 06:15:20 INFO - PROCESS | 6694 | Values: 75.0 77.0 75.0 115.0 76.0 76.0 76.0 76.0 107.0 80.0 06:15:20 INFO - PROCESS | 6694 | 06:15:20 INFO - PROCESS | 6694 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:82.00 stddev:16.28 (19.8%) stddev-sans-first:16.93 06:15:20 INFO - PROCESS | 6694 | Values: 83.0 82.0 116.0 81.0 82.0 82.0 122.0 82.0 83.0 107.0 06:15:20 INFO - PROCESS | 6694 | 06:15:20 INFO - PROCESS | 6694 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:15:20 INFO - PROCESS | 6694 | Values: 118.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 118.0 118.0 06:15:20 INFO - PROCESS | 6694 | 06:15:20 INFO - PROCESS | 6694 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 06:15:20 INFO - PROCESS | 6694 | Values: 146.0 145.0 146.0 147.0 147.0 146.0 145.0 145.0 146.0 146.0 06:15:20 INFO - PROCESS | 6694 | 06:15:20 INFO - PROCESS | 6694 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 06:15:20 INFO - PROCESS | 6694 | Values: 84.0 84.0 86.0 85.0 84.0 84.0 85.0 84.0 84.0 85.0 06:15:20 INFO - PROCESS | 6694 | 06:15:20 INFO - PROCESS | 6694 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:0.92 (1.7%) stddev-sans-first:0.87 06:15:20 INFO - PROCESS | 6694 | Values: 54.0 51.0 52.0 53.0 52.0 53.0 53.0 53.0 54.0 53.0 06:15:20 INFO - PROCESS | 6694 | 06:15:20 INFO - PROCESS | 6694 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 06:15:20 INFO - PROCESS | 6694 | Values: 61.0 62.0 62.0 63.0 63.0 62.0 62.0 62.0 62.0 62.0 06:15:20 INFO - PROCESS | 6694 | 06:15:20 INFO - PROCESS | 6694 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.50 stddev:3.84 (4.6%) stddev-sans-first:3.52 06:15:20 INFO - PROCESS | 6694 | Values: 88.0 79.0 87.0 79.0 82.0 85.0 80.0 87.0 79.0 79.0 06:15:20 INFO - PROCESS | 6694 | 06:15:20 INFO - PROCESS | 6694 | [#11] stanford-crypto-ccm Cycles:10 Average:137.70 Median:135.50 stddev:13.70 (10.1%) stddev-sans-first:14.50 06:15:20 INFO - PROCESS | 6694 | Values: 140.0 129.0 134.0 135.0 133.0 136.0 129.0 138.0 175.0 128.0 06:15:20 INFO - PROCESS | 6694 | 06:15:20 INFO - PROCESS | 6694 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.60 Median:167.00 stddev:1.71 (1.0%) stddev-sans-first:1.81 06:15:20 INFO - PROCESS | 6694 | Values: 167.0 167.0 167.0 164.0 170.0 167.0 166.0 165.0 165.0 168.0 06:15:20 INFO - PROCESS | 6694 | 06:15:20 INFO - PROCESS | 6694 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:2.11 (3.1%) stddev-sans-first:2.15 06:15:20 INFO - PROCESS | 6694 | Values: 69.0 66.0 65.0 69.0 67.0 67.0 70.0 66.0 64.0 70.0 06:15:20 INFO - PROCESS | 6694 | -------- Summary: end -------- 06:15:20 INFO - PROCESS | 6694 | 06:15:21 INFO - TEST-INFO | 6694: exit 0 06:15:21 INFO - TEST-OK | kraken | took 61575ms 06:15:21 INFO - SUITE-END | took 1179s 06:15:22 INFO - Completed test suite (00:19:39) 06:15:22 INFO - javascript benchmark 06:15:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2985.9999999999995, 3047.588575542301, 3052.4810782167037, 3077.0461157041304, 3100.7519398448126, 5202.973985130078, 5237.607179461546, 5242.21366794981, 5323.547498462631, 5333.466653334669, 5279.788808447667, 5295.205719142131, 5307.2569840222395, 5307.363116426025, 5308.124159513685, 4825.227963525827, 4860.927086093711, 4873.805047798084, 4912.48418916014, 4912.950870491285, 4788.449328327252, 4838.491958344376, 4862.29496722975, 4881.926771098437, 4917.926231106536, 4871.488493708162, 4904.0, 4928.507149285078, 4967.528084831935, 4980.05378977993, 481.7789130001106, 4904.411470623512, 4912.508749125094, 4928.125265254985, 4975.975120124376, 3424.6159016879974, 4656.41794775653, 4681.765911704401, 4688.5077066907825, 4878.926816097762, 5284.682919024871, 5293.920591191135, 5294.047071527124, 5295.152775555931, 5309.283246761715, 5586.190002449663, 5695.686737229451, 5721.513671337942, 5721.7711291548285, 5792.391798861143, 5569.192467092289, 5580.135079062752, 5602.467765562265, 5619.80330688424, 5634.802781902655, 5226.634135610509, 5278.9208161877605, 5290.841274761763, 5292.338457692788, 5293.179557168645, 5810.0, 5817.534597232211, 5820.621659592113, 5821.79623713168, 5824.708764561755, 5481.643693160012, 5525.143602741581, 5581.413951535112, 5640.661560306313, 5660.632058916157, 5731.512821410143, 5757.913631295534, 5763.308402991668, 5764.221830052889, 5824.504917082011, 5740.253767010346, 5744.913826292609, 5748.597598168171, 5749.195112684228, 5749.511291540266, 5580.86047848807, 5625.46558076982, 5631.380548139701, 5702.714864256771, 5807.82576522705, 4237.87286381409, 4275.786210689453, 4281.743095414286, 4285.078708077778, 4287.228298906227, 3848.4034974578985, 3852.614738526125, 3864.246471937945, 3882.495275614152, 3885.669718073995, 5406.270153529302, 5407.70257635826, 5415.377231618336, 5417.133258678593, 5417.512423881791, 5701.173329867146, 5739.368669446358, 5749.0, 5757.0788673811985, 5759.884802304015, 5340.0, 5345.118055520873, 5352.652077614943, 5352.9732351338, 5360.544353729899, 4806.375171227718, 4812.302216178635, 4813.892804654949, 4816.530958057756, 4829.73436460991, 5954.910676339859, 5957.851053723605, 5964.522838172936, 5970.283565972111, 5975.492083172979, 5607.411221821813, 5661.264035675335, 5753.1945527627, 5759.280089988752, 5764.711764411679, 5839.299284085937, 5890.4993075587345, 5906.232189815297, 5933.347331793413, 6015.849603759941, 5635.577331700221, 5654.660720356792, 5654.915176272277, 5659.236003139524, 5663.348714897675, 5546.916796247979, 5738.0, 5747.08046712524, 5752.28096487939, 5755.740991655469, 5424.430434804289, 5471.23402723627, 5477.4248703887115, 5500.889982200413, 5540.695261760642, 5523.364813046551, 5529.0, 5573.27547418833, 5583.8883222336135, 5593.188987596857, 5500.092484740133, 5503.559715222853, 5512.062949298549, 5517.282753242052, 5520.033994051106, 5450.890982180414, 5513.8345849624575, 5537.0, 5554.416786237387, 5563.860903477445, 5439.755211015593, 5478.150886612581, 5479.424660410599, 5511.58663100261, 5527.281453411031], "value": 5201.424550037205, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.2737600055926, 598.4434475937378, 610.2890132995058, 617.1945610977672, 617.5245061302795, 30347.848260758692, 33121.33757324852, 33207.16982075446, 33211.66788332116, 33212.66787332126, 34469.82765086177, 43070.0, 43917.12165756683, 44044.33933490992, 47948.0, 8808.91191088089, 8920.286377089817, 8931.50876701781, 8936.285097192242, 8941.284697224206, 8792.032876383593, 8877.0, 8884.644614215424, 8891.510966896818, 8893.244074253696, 8046.758597242063, 8236.62935167916, 10462.215333849954, 10705.411202383866, 10737.194710396712, 10680.359178449318, 10685.519151638116, 10740.570377184904, 10753.354798712064, 10759.677209683721, 10615.946920265427, 10685.252032357737, 10691.358518488916, 10693.78612427747, 10697.304675196086, 41561.0, 41804.58195418037, 41827.0, 41881.79059104715, 41886.1622767546, 3377.3751855906735, 3465.462853257749, 3569.607343192247, 3610.7472476926628, 3623.710103191738, 30773.692263077308, 31017.844910775526, 31239.06282811519, 33260.168495787555, 33345.0, 4124.711270211086, 4211.642010429086, 4280.614744672995, 4341.088371442001, 4463.129689710508, 331352.0, 331652.0, 333201.0, 333644.0, 334627.99999999756, 59047.0, 59163.0, 59469.405305946384, 59474.0, 59627.403725962184, 62775.03637154463, 62818.68590657017, 62861.68569157125, 62967.6851615739, 62997.37002629915, 15829.445969391016, 16046.67906641884, 16053.839461605468, 16055.759163612554, 16139.596510087107, 11659.825102623467, 11662.300261984308, 11662.300261984308, 11668.824967625493, 11670.766584668429, 16594.419195328104, 17068.317267309416, 18140.47449422744, 19165.32921347774, 19419.514512137026, 6567.211934567787, 6914.343137401939, 7065.4700897432895, 7126.790694884602, 7201.495895287279, 956.7464621875208, 996.6362277768562, 1012.4330374990029, 1060.151878497199, 1135.840982262484, 30569.69430305713, 30963.535546966814, 31143.68856311408, 31716.841415792773, 31772.20569485735, 1087.141158484804, 1101.9504122314515, 1112.1436493899653, 1155.7052951497315, 1185.6087491127907, 15832.366705331888, 16652.417165399394, 16724.163791810603, 16742.83257167437, 16802.327906883587, 490524.0, 491601.0, 493273.0, 495017.0, 495818.0, 47659.0, 49206.30952678563, 55327.44672553303, 55961.0, 57203.42796571981, 1335.826342575459, 1357.511295933463, 1361.598328493097, 1365.5630198336437, 1374.223563686514, 30159.157542033183, 32635.0, 32644.34711305808, 33074.17314567155, 33277.83361083179, 49162.0, 52068.479315206365, 54219.0, 54219.45780542144, 58842.0, 462578.0, 466657.0, 466860.0, 467732.0, 467882.2847086078, 41265.0, 42156.0, 42384.576154239294, 42430.5756942439, 42934.35598465963, 45743.54256457526, 46372.7681361591, 46490.30264545967, 46523.53476465192, 49873.755680993716, 39882.40176397414, 39893.40159897662, 40616.0, 40618.59381406266, 41997.1600567993, 39594.80202598969, 39809.80095099506, 39830.2033959325, 40541.79729101453, 40737.59262407457, 40003.19985600713, 40458.79770601246, 41260.38109428421, 41483.585164147975, 41508.0, 31922.20194495156, 35391.646083538835, 35944.0, 36394.8180259097, 36517.26965460623, 27200.0, 27624.303868342027, 27716.722832771415, 27974.300642483286, 28121.71878281191], "value": 20191.651569380792, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.6709011254702, 365.444524323029, 380.6060727147403, 382.93270900090266, 410.5237924008151, 14123.929380353096, 17950.0, 18810.43568692938, 19095.33166339175, 20157.899210503925, 18191.363302284422, 18997.715034274497, 19002.42992710221, 19229.90385048076, 19239.13423895928, 5483.506484416402, 5764.16419619157, 5770.913436298438, 5772.480476757091, 5773.624714393551, 4087.409982617333, 4269.7224680395675, 5711.7715291388295, 5806.361300256968, 6512.641804700739, 6488.805335839932, 6492.285848556655, 6500.869982600345, 6507.05647681086, 6523.249826269992, 6418.101465794793, 6511.0, 6590.604563726191, 6600.80197594073, 6603.514209302893, 5760.36635970043, 5767.134929760569, 5791.160281759121, 5802.912956305659, 5803.274590676166, 21660.0, 21793.782062179333, 21812.345629631138, 21894.23370182036, 22018.78896660683, 2280.407094155515, 2330.34750269923, 2376.7860892519757, 2443.438009257881, 2518.1941778630844, 14002.439902403892, 15497.45758898433, 15820.288087036111, 16021.679566408724, 16757.49727508177, 2026.2401599400225, 2027.638765906218, 2039.350281358505, 2110.134844713675, 2121.844242095354, 81520.59239703823, 87136.0, 91368.0, 93861.5306923461, 93883.53058234733, 16565.751513727304, 16904.746428803577, 17108.657826843395, 17221.56946076358, 17441.215145318238, 31446.0, 31466.685333146375, 31658.841705791783, 31734.68265317317, 32001.19997000047, 9017.549122543847, 9248.306377021616, 9257.259419246444, 9457.668981585612, 9529.380590261611, 7599.658015389321, 7631.656575454007, 7667.846643067108, 7869.0, 7927.960360198162, 8626.309895208367, 8697.565121743888, 8762.283692055484, 8914.974777900625, 8986.370954033286, 3075.7693173012112, 3251.7398608111293, 3255.3326568053494, 3455.87904423344, 3492.7031202348085, 853.6884037326331, 952.518977916148, 956.3735753081743, 971.0338213477635, 996.1881066930429, 19326.0, 19785.901070494554, 19869.30457433983, 20107.698384524243, 20138.0, 949.6106596295485, 976.9706908792748, 984.3011461862015, 993.3493561716942, 998.1565577087349, 10869.728256793485, 10999.670009899715, 11084.279521831055, 11086.667399978014, 11103.666889993314, 328615.0, 334349.0, 335628.0, 430963.0, 434095.0, 94969.5251523738, 97880.0, 98234.0, 99695.0, 101362.49318753359, 1023.2070145637042, 1054.8312270036756, 1076.3972175581544, 1083.3878858444953, 1086.5219303506433, 12951.481940722266, 16365.918170409548, 16536.917315413346, 17616.0, 18113.275468981094, 38798.04640048727, 39854.60145398509, 39975.400368993905, 42418.57581424146, 44733.329000064376, 53613.83440904346, 53848.46151538435, 56517.0, 56865.71567142138, 58287.70856145692, 6295.905561416491, 8165.755027349189, 8166.265036146775, 8372.330213582776, 8655.783605409915, 12037.879621204027, 13374.13068150567, 13406.597802065953, 13575.253361065235, 13586.932065340005, 11379.54481820751, 11520.078393728649, 11602.18784685064, 12098.0, 12165.600955890186, 11505.539778409106, 11541.134414919083, 11580.478878450322, 11732.472038758106, 11872.347020913932, 10868.293560918515, 11378.203525753448, 11396.715082122682, 11829.940850295694, 12220.75558488843, 8359.916400835913, 8364.66541338364, 8477.61850716707, 8522.147785221428, 8550.187732165434, 11450.828237576276, 11578.94210528942, 11662.067034637039, 11676.357800321064, 12097.274163550215], "value": 9938.608052536689, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1427.4004917934467, 1458.030409777498, 1573.843225229456, 1728.2654871679533, 1767.5316041249064, 7510.361619262356, 7763.883541746878, 8081.676732930676, 8621.008584012841, 8621.439606425585, 7984.520928744279, 8288.627011784469, 8326.458780179299, 8544.829103417927, 8549.61526731297, 2088.945082733221, 2101.359085478928, 2117.8093971542557, 2121.586290673319, 2122.2253877334815, 1905.990470047648, 1972.437855211265, 2110.662294032955, 2155.8706477611313, 2195.3633446300555, 1938.6704260275787, 1939.6508628446875, 1959.804019598043, 2008.8895110768901, 2107.9367618971455, 2096.3920463065692, 2097.2345094040716, 2098.58028394321, 2099.0449345547813, 2110.303599812058, 2092.612866619665, 2094.3507512670967, 2098.475381154711, 2136.1028368085285, 2142.967855482169, 7815.843683126305, 7860.567668778215, 7923.762287131395, 7933.603319834043, 7934.603269836485, 5028.899422011576, 5169.56058735008, 5178.870528236786, 5188.948110518922, 5191.636585439021, 3021.2748940254182, 3195.328980914011, 3215.887443939451, 3233.757468189872, 3260.5761251037216, 963.4412041016263, 1005.7284533176074, 1010.2927950434652, 1038.6468600675807, 1047.8742550893865, 11899.405029748477, 11928.224665396721, 11937.701557461047, 11939.283642981449, 11958.282503049844, 4303.311470164758, 4506.7070640408265, 4577.610903073276, 4611.677182597186, 4616.60758835496, 9971.40171589707, 9975.800483990279, 9994.250431217688, 10001.399916005063, 10006.849897251546, 5253.789848406097, 5259.526642602108, 5259.605529585297, 5264.315638966987, 5266.236395722599, 4683.344331793552, 4794.688345257547, 4828.396450443694, 4846.854594362175, 4847.830325938575, 3621.6740493355724, 3644.653757892996, 3731.0, 3739.1586892948867, 3753.3619284721663, 1216.2398500936915, 1223.614561413152, 1231.445849367788, 1237.4864431260926, 1249.3503378243445, 793.8729803231455, 902.6208992223281, 930.7393929699695, 948.3346864369164, 980.5587485631495, 5640.8871822563315, 5705.942940570624, 5709.68596727184, 5710.200571919934, 5814.9709251454315, 909.713440266314, 946.7680418297424, 955.102203928319, 960.9855852162223, 961.2838435365697, 3849.9037524061564, 3905.7461265017682, 3906.257811015898, 3989.6209860063245, 4000.6199411055904, 10288.845667314847, 10557.0, 10650.254482186327, 10667.039966403061, 10693.679189624323, 10322.277440579088, 10423.791524169474, 10610.522526486327, 10617.946910265398, 10636.361818290927, 7987.800304992422, 8043.557604331818, 8193.918060819435, 8208.958955205186, 8217.178282171855, 5338.172583249602, 5488.17677348401, 5588.105903055492, 5623.3814280428305, 5648.745806438638, 9728.22174226046, 9801.607935682492, 9822.607095716092, 9862.753431164278, 9865.45739984279, 9741.756456088655, 9856.753581160528, 9958.203343732628, 10024.047715467019, 10070.44612546317, 6856.965715171392, 6963.199232088172, 6984.0, 6991.475639327173, 6994.2306346302885, 7905.723299684483, 7938.64276107565, 7974.481658692166, 7981.680732770624, 7982.1618730032515, 7223.783286501413, 7331.3768329692575, 7365.7790266292095, 7382.5939573323985, 7385.409167266498, 7126.679299431435, 7191.316824901626, 7240.0, 7313.744018959311, 7334.486585939147, 6434.517411194086, 6548.246951600627, 6559.770408035696, 6564.934350656432, 6571.474282057328, 5005.224190250517, 5058.570021548209, 5067.0, 5123.103456895103, 5285.735713214401, 5058.747062646779, 5075.3402057732255, 5104.846854594368, 5121.8719532012, 5272.7100009499845], "value": 4412.393608603131, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.9451098802215, 320.99528475870505, 326.7745255773516, 329.68515068109957, 329.9606240342921, 5027.62292828038, 5121.129408000639, 5184.792608295664, 5212.322398088253, 5233.921491177635, 4939.8024079036795, 5142.511461411169, 5147.794088236476, 5148.279240906276, 5153.037003722856, 4042.2521833460755, 4047.433359329696, 4060.451839001741, 4070.4708387909677, 4080.1431699343025, 3920.176762879799, 4028.838846446153, 4031.21391328691, 4039.515258169024, 4089.7750623715683, 3954.4463775071367, 3964.9801750991205, 3993.700472464562, 3996.2216813518, 4006.198760247962, 3970.4639873617125, 3973.9071755267387, 4022.1955608878343, 4037.2329257440992, 4061.614146656063, 3414.778039427429, 3544.805035723034, 3559.94660080099, 3560.9168636347767, 3562.69717074049, 5043.9747801260755, 5047.889464317845, 5056.570191533724, 5060.0, 5060.49395060491, 4513.1650644630845, 4537.705049171826, 4555.362249285103, 4577.816887324537, 4596.632269418472, 5140.3831540215415, 5371.489708477728, 5374.140137577969, 5395.541378982791, 5398.703071331075, 3836.9808150959348, 3863.555691095532, 3869.2454971280613, 3877.5346958364894, 3884.184321292532, 5587.497125258706, 5611.270534830527, 5611.9438805612235, 5615.2700148980375, 5623.0721930881355, 3932.4494570760116, 3967.0, 3971.801409929492, 3974.3307810719566, 3975.920481590352, 3833.884983450501, 3956.2878681837547, 3991.8802435926386, 4003.2794097062224, 4010.3783913493453, 4326.6754993375625, 4422.71252368595, 4476.843310484118, 4567.611753000966, 4573.931391029138, 5445.6385903524115, 5450.048714681903, 5456.372517160498, 5468.781248750085, 5472.534834539029, 1312.252016350671, 1339.430741934674, 1361.0200655528004, 1364.8498665146826, 1381.2886363522794, 913.9862902056475, 935.3919952031234, 943.1982814607529, 945.1493655709779, 950.2255661635745, 5267.209918512177, 5268.947310526923, 5272.367315922113, 5308.893822123536, 5331.173668081454, 5474.494514008679, 5547.944520554743, 5593.608447408724, 5600.411956744565, 5619.522340601013, 5186.429492755794, 5210.531052205244, 5210.76551555181, 5230.320058392384, 5236.869078273074, 2584.754448327406, 2595.6120369260325, 2603.7266087060966, 2605.830621009666, 2610.2430295214554, 4799.616030717534, 4990.301357809837, 5020.397552293748, 5051.696898186121, 5063.594912406998, 4926.275803468758, 4944.703317800943, 4949.7030178189425, 4956.256561515802, 4982.651214415028, 4997.4512998370365, 5030.547250747451, 5036.952643650612, 5043.5965122790085, 5060.468650791688, 4878.56092951636, 4897.681650692836, 5262.736863156903, 5606.915896261477, 5635.295588051494, 5551.666899986014, 5574.609777315549, 5579.218909352775, 5585.525230355465, 5594.832155035356, 5652.3217213934595, 5802.564807639359, 5834.15404766315, 5834.854128646648, 5868.589198756046, 3943.467631869661, 3948.0, 3960.702947278908, 3989.7805620691142, 4013.8996525087105, 5413.566914646897, 5513.3108361454815, 5515.641483303572, 5632.549396048388, 5641.9435805641415, 5426.891462170655, 5427.864303392446, 5434.945650543444, 5467.945320546903, 5477.589860461543, 5205.553389906738, 5385.299911011543, 5407.459254074561, 5426.565874729933, 5431.158170483582, 5336.653117547347, 5358.892822143614, 5378.704171270618, 5382.19267109921, 5382.946170538245, 5413.729313534386, 5440.319960004999, 5477.4248703887115, 5558.471945165203, 5564.415736347625, 5146.908207974744, 5287.7620507078045, 5314.22943673173, 5390.730463476889, 5391.2235198873395], "value": 4067.513989545428, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.8224426137726, 756.6670664907442, 757.0839284465796, 777.6228529163351, 791.5132193700875, 14284.857151428483, 14328.0, 14650.70698586029, 15314.0, 15435.305411256506, 13415.932920335408, 13443.731125377486, 13623.523176688794, 13673.179609223429, 13714.108582942103, 669.357416879796, 765.7855800375904, 779.372605052935, 779.95710235937, 780.5160800303792, 685.3763075601204, 809.5709274084744, 821.109096630157, 824.3281725393815, 826.8304997475533, 850.124371896944, 855.2516548020482, 855.5850412549909, 857.2413414128509, 857.2841677199546, 686.5228666077079, 844.0293662288356, 844.5523872347604, 845.4335595151264, 846.0270688707974, 514.8172398798448, 611.6574718157846, 627.5387590121258, 628.2178687534004, 632.2223664892163, 14107.506237281646, 14148.717025659429, 14151.0, 14151.787723184161, 14157.716845663132, 12657.367131643474, 12785.488580456771, 13168.341582920815, 13710.52013179544, 13719.45122195111, 11578.53685852565, 11600.053828555992, 11638.1271404645, 11826.0, 11914.225575337576, 4175.394567787654, 4190.329547272452, 4229.619334259901, 4239.3217085266515, 4295.162443323553, 59698.70150649262, 60470.0, 60596.69701651508, 61530.69234653843, 64307.0, 10168.881782751956, 10327.793444131226, 10443.791124177626, 10528.789424211473, 10608.0, 18750.0, 18846.43460696181, 18979.525511862314, 18990.24039038423, 19261.711074333896, 7709.42179336552, 7770.261825126604, 7817.8827317590285, 7824.0, 7847.293743563107, 4423.712458690175, 4444.355568442623, 4451.265541185668, 4525.366448697185, 4534.523874993144, 3181.4750566156786, 3292.703656670911, 3294.769366144395, 3302.256992176741, 3307.570015897918, 588.3763210996358, 606.1756011823916, 624.7875722254455, 627.212847875922, 629.902365133405, 720.9222212791805, 729.3946024799404, 730.9707611695472, 777.6461709921972, 797.6849144587856, 9524.666636667684, 9558.330916835755, 9707.854382184272, 9778.804423911482, 9788.951055244679, 677.5799004617169, 678.955867868587, 738.2801768275996, 746.1046743907333, 751.1136858507015, 4213.5154457237195, 4369.541198174209, 4451.399061126771, 4476.977615111969, 4675.392199014106, 67982.66008669925, 69141.96287055698, 69957.0, 78283.21716782759, 86949.56525217333, 43668.563314367086, 44192.55807441884, 54556.727216363666, 69710.65144674244, 69901.65049174824, 39157.80421097933, 55617.0, 62208.68895655493, 63108.0, 66720.0, 9156.816863662556, 9297.349185556946, 9434.858477122985, 9603.135717785433, 9726.951365243129, 32892.83553582313, 42990.14019719526, 43286.35070473883, 43765.12469750651, 44622.55377446314, 52114.73942630263, 59183.408165919514, 61761.382386175566, 61894.38105618886, 62290.37709623027, 12176.747301749205, 12218.572349968064, 12442.502299907903, 12447.253164810141, 13035.934820325838, 13521.391537381038, 13621.0, 13687.45250190021, 13823.377947992163, 14660.413583456542, 12562.560310389457, 12609.684757881127, 12927.5475358362, 12943.158694684815, 13303.866961330263, 12175.029740720476, 12507.37755734656, 12695.0, 13086.541971030969, 13102.344882756015, 12573.861964765705, 12618.55835045769, 12975.545855894998, 13298.401571929093, 13659.521916732867, 10567.0, 10641.787164256517, 10690.572377104829, 10972.945135274273, 10987.945060274647, 10209.846852297072, 10406.427646479517, 10677.51951162184, 10746.753408485272, 10990.230683852373], "value": 6911.647699516054, "unit": "score"}], "name": "dromaeo_css", "value": 7112.831105029675, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 112.0, 110.0, 113.0, 111.0, 112.0, 113.0, 111.0, 113.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 126.0, 168.0, 123.0, 125.0, 129.0, 121.0, 153.0, 121.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 160.0, 161.0, 161.0, 159.0, 161.0, 160.0, 163.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 115.0, 76.0, 76.0, 76.0, 76.0, 107.0, 80.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 116.0, 81.0, 82.0, 82.0, 122.0, 82.0, 83.0, 107.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 147.0, 147.0, 146.0, 145.0, 145.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 86.0, 85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 52.0, 53.0, 52.0, 53.0, 53.0, 53.0, 54.0, 53.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 63.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 79.0, 87.0, 79.0, 82.0, 85.0, 80.0, 87.0, 79.0, 79.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 129.0, 134.0, 135.0, 133.0, 136.0, 129.0, 138.0, 175.0, 128.0], "value": 137.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 167.0, 164.0, 170.0, 167.0, 166.0, 165.0, 165.0, 168.0], "value": 166.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 65.0, 69.0, 67.0, 67.0, 70.0, 66.0, 64.0, 70.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1498.3999999999999, "alertThreshold": 2.0}]} 06:15:22 INFO - Return code: 0 06:15:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:15:22 INFO - # TBPL SUCCESS # 06:15:22 INFO - Running post-action listener: _resource_record_post_action 06:15:22 INFO - [mozharness: 2016-10-29 13:15:22.374757Z] Finished run-tests step (success) 06:15:22 INFO - Running post-run listener: _resource_record_post_run 06:15:22 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 390815744; Read time: 224; Write time: 294936 06:15:22 INFO - TinderboxPrint: CPU usage
13.1% 06:15:22 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 224 06:15:22 INFO - TinderboxPrint: I/O write bytes / time
390,815,744 / 294,936 06:15:22 INFO - TinderboxPrint: CPU idle
8,292.9 (86.9%) 06:15:22 INFO - TinderboxPrint: CPU user
1,199.1 (12.6%) 06:15:22 INFO - TinderboxPrint: Swap in / out
0 / 0 06:15:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103559168; Read time: 0; Write time: 91916 06:15:22 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286900224; Read time: 208; Write time: 202980 06:15:22 INFO - Running post-run listener: _upload_blobber_files 06:15:22 INFO - Blob upload gear active. 06:15:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:15:22 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 06:15:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:15:23 INFO - (blobuploader) - INFO - Open directory for files ... 06:15:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:15:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:15:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:27 INFO - (blobuploader) - INFO - Done attempting. 06:15:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:15:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:15:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:30 INFO - (blobuploader) - INFO - Done attempting. 06:15:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:15:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:15:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:30 INFO - (blobuploader) - INFO - Done attempting. 06:15:30 INFO - (blobuploader) - INFO - Iteration through files over. 06:15:30 INFO - Return code: 0 06:15:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:15:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:15:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef10c367eda512f1e537639a02c5b507c1c58d78410b3a64412af8cd01a5b7e2d68223983c853810bccfe426908466cdcbeee4216c1f37d0add8c123b52f96be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4287c07e1405c2e54714a49b84fa655b737210d02e0bae6e4ffd77e79a375c715c24866456acfc80976d46fa8825c305147b4a1abe8bfdbc7c5fc80550d835d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d05ce3724ff66e1aa9b211be98b425e04a2e81e8454f51f8dadc21c2b5d7d398477f55f727413f0420f448377724c6f97b64275cd05ef3a3a7795a9d97e772e4"} 06:15:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:15:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:15:30 INFO - Contents: 06:15:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef10c367eda512f1e537639a02c5b507c1c58d78410b3a64412af8cd01a5b7e2d68223983c853810bccfe426908466cdcbeee4216c1f37d0add8c123b52f96be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4287c07e1405c2e54714a49b84fa655b737210d02e0bae6e4ffd77e79a375c715c24866456acfc80976d46fa8825c305147b4a1abe8bfdbc7c5fc80550d835d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d05ce3724ff66e1aa9b211be98b425e04a2e81e8454f51f8dadc21c2b5d7d398477f55f727413f0420f448377724c6f97b64275cd05ef3a3a7795a9d97e772e4"} 06:15:30 INFO - Running post-run listener: copy_logs_to_upload_dir 06:15:30 INFO - Copying logs to upload dir... 06:15:30 INFO - mkdir: /builds/slave/test/build/upload/logs 06:15:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.712426 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-29 06:15:30.721619) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 06:15:30.724721) ========= 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=03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef10c367eda512f1e537639a02c5b507c1c58d78410b3a64412af8cd01a5b7e2d68223983c853810bccfe426908466cdcbeee4216c1f37d0add8c123b52f96be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4287c07e1405c2e54714a49b84fa655b737210d02e0bae6e4ffd77e79a375c715c24866456acfc80976d46fa8825c305147b4a1abe8bfdbc7c5fc80550d835d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d05ce3724ff66e1aa9b211be98b425e04a2e81e8454f51f8dadc21c2b5d7d398477f55f727413f0420f448377724c6f97b64275cd05ef3a3a7795a9d97e772e4"} build_url:https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011261 build_url: 'https://queue.taskcluster.net/v1/task/Bsnd1kLGTOuGcssAmtt1Cg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef10c367eda512f1e537639a02c5b507c1c58d78410b3a64412af8cd01a5b7e2d68223983c853810bccfe426908466cdcbeee4216c1f37d0add8c123b52f96be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4287c07e1405c2e54714a49b84fa655b737210d02e0bae6e4ffd77e79a375c715c24866456acfc80976d46fa8825c305147b4a1abe8bfdbc7c5fc80550d835d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d05ce3724ff66e1aa9b211be98b425e04a2e81e8454f51f8dadc21c2b5d7d398477f55f727413f0420f448377724c6f97b64275cd05ef3a3a7795a9d97e772e4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 06:15:30.750056) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 06:15:30.750424) ========= 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=03627c79f6bb3d1578c4a402000001ba-1477740693.453442-1127147408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 06:15:30.836089) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 06:15:30.836408) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 06:15:30.836699) ========= ========= Total master_lag: 0.17 =========