builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1478108804.31 results: success (0) buildid: 20161102073203 builduid: 1b009f6126c14a1187524a8fc485784c revision: 3bfde35a0d18a643485ffd5073f3bc6a79e0ae48 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-02 10:46:44.309657) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-02 10:46:44.310150) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-02 10:46:44.310430) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-02 10:46:44.326159) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 10:46:44.326768) ========= 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=ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-02 10:46:44-- 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% 42.7M=0s 2016-11-02 10:46:44 (42.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149503 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 10:46:44.490694) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 10:46:44.491041) ========= 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=ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017165 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 10:46:44.541065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 10:46:44.541417) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3bfde35a0d18a643485ffd5073f3bc6a79e0ae48 --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 3bfde35a0d18a643485ffd5073f3bc6a79e0ae48 --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=ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-02 10:46:44,841 truncating revision to first 12 chars 2016-11-02 10:46:44,841 Setting DEBUG logging. 2016-11-02 10:46:44,841 attempt 1/10 2016-11-02 10:46:44,842 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3bfde35a0d18?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-02 10:46:45,149 unpacking tar archive at: mozilla-central-3bfde35a0d18/testing/mozharness/ program finished with exit code 0 elapsedTime=0.618442 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 10:46:45.173351) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-02 10:46:45.173695) ========= script_repo_revision: 3bfde35a0d18a643485ffd5073f3bc6a79e0ae48 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-02 10:46:45.174081) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-02 10:46:45.174347) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-02 10:46:45.184976) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-11-02 10:46:45.185607) ========= /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=ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:46:45 INFO - MultiFileLogger online at 20161102 10:46:45 in /builds/slave/test 10:46:45 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 10:46:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:46:45 INFO - {'append_to_log': False, 10:46:45 INFO - 'base_work_dir': '/builds/slave/test', 10:46:45 INFO - 'blob_upload_branch': 'Firefox', 10:46:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:46:45 INFO - 'branch': 'Firefox', 10:46:45 INFO - 'buildbot_json_path': 'buildprops.json', 10:46:45 INFO - 'config_files': ('talos/linux_config.py',), 10:46:45 INFO - 'default_actions': ('clobber', 10:46:45 INFO - 'read-buildbot-config', 10:46:45 INFO - 'download-and-extract', 10:46:45 INFO - 'populate-webroot', 10:46:45 INFO - 'create-virtualenv', 10:46:45 INFO - 'install', 10:46:45 INFO - 'run-tests'), 10:46:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:46:45 INFO - 'download_minidump_stackwalk': True, 10:46:45 INFO - 'download_symbols': 'ondemand', 10:46:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:46:45 INFO - 'tooltool.py': '/tools/tooltool.py', 10:46:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:46:45 INFO - '/tools/misc-python/virtualenv.py')}, 10:46:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:46:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:46:45 INFO - 'installer_path': 'installer.exe', 10:46:45 INFO - 'log_level': 'info', 10:46:45 INFO - 'log_name': 'talos', 10:46:45 INFO - 'log_to_console': True, 10:46:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:46:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:46:45 INFO - 'opt_config_files': (), 10:46:45 INFO - 'pip_index': False, 10:46:45 INFO - 'sps_profile': False, 10:46:45 INFO - 'sps_profile_interval': 0, 10:46:45 INFO - 'suite': 'dromaeojs', 10:46:45 INFO - 'system_bits': '32', 10:46:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:46:45 INFO - 'title': 'talos-linux64-ix-035', 10:46:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:46:45 INFO - 'use_talos_json': True, 10:46:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:46:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:46:45 INFO - 'work_dir': 'build'} 10:46:45 INFO - [mozharness: 2016-11-02 17:46:45.581453Z] Running clobber step. 10:46:45 INFO - Running pre-action listener: _resource_record_pre_action 10:46:45 INFO - Running main action method: clobber 10:46:45 INFO - rmtree: /builds/slave/test/build 10:46:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:46:46 INFO - Running post-action listener: _resource_record_post_action 10:46:46 INFO - [mozharness: 2016-11-02 17:46:46.061163Z] Finished clobber step (success) 10:46:46 INFO - [mozharness: 2016-11-02 17:46:46.061276Z] Running read-buildbot-config step. 10:46:46 INFO - Running pre-action listener: _resource_record_pre_action 10:46:46 INFO - Running main action method: read_buildbot_config 10:46:46 INFO - Using buildbot properties: 10:46:46 INFO - { 10:46:46 INFO - "project": "", 10:46:46 INFO - "product": "firefox", 10:46:46 INFO - "script_repo_revision": "production", 10:46:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:46:46 INFO - "repository": "", 10:46:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:46:46 INFO - "buildid": "20161102073203", 10:46:46 INFO - "pgo_build": "True", 10:46:46 INFO - "basedir": "/builds/slave/test", 10:46:46 INFO - "buildnumber": 609, 10:46:46 INFO - "slavename": "talos-linux64-ix-035", 10:46:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:46:46 INFO - "platform": "ubuntu64_hw", 10:46:46 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:46:46 INFO - "branch": "mozilla-central", 10:46:46 INFO - "repo_path": "mozilla-central", 10:46:46 INFO - "revision": "3bfde35a0d18a643485ffd5073f3bc6a79e0ae48", 10:46:46 INFO - "stage_platform": "linux64-pgo", 10:46:46 INFO - "builduid": "1b009f6126c14a1187524a8fc485784c", 10:46:46 INFO - "slavebuilddir": "test" 10:46:46 INFO - } 10:46:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/C8nwRexxSxqmfHiWzbfb4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:46:46 INFO - Running post-action listener: _resource_record_post_action 10:46:46 INFO - [mozharness: 2016-11-02 17:46:46.063703Z] Finished read-buildbot-config step (success) 10:46:46 INFO - [mozharness: 2016-11-02 17:46:46.063791Z] Running download-and-extract step. 10:46:46 INFO - Running pre-action listener: _resource_record_pre_action 10:46:46 INFO - Running main action method: download_and_extract 10:46:46 INFO - mkdir: /builds/slave/test/build/tests 10:46: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')]} 10:46:46 INFO - trying https://queue.taskcluster.net/v1/task/C8nwRexxSxqmfHiWzbfb4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:46:46 INFO - Downloading https://queue.taskcluster.net/v1/task/C8nwRexxSxqmfHiWzbfb4g/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 10:46:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C8nwRexxSxqmfHiWzbfb4g/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 10:46:46 INFO - Downloaded 1361 bytes. 10:46:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:46:46 INFO - Using the following test package requirements: 10:46:46 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:46:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:46:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:46:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:46 INFO - u'jsshell-linux-x86_64.zip'], 10:46:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:46:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:46:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:46:46 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:46:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:46:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:46:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:46:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C8nwRexxSxqmfHiWzbfb4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:46:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C8nwRexxSxqmfHiWzbfb4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:46:46 INFO - Fetch https://queue.taskcluster.net/v1/task/C8nwRexxSxqmfHiWzbfb4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:46:47 INFO - Http code: 200 10:46:47 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 10:46:47 INFO - x-amz-cf-id: YzBIx1jBhEy6RvS6RKPqjihl_3Yl2Ese21eJCudg5duLR_bsWJL6iQ== 10:46:47 INFO - x-amz-version-id: dIKYZRNPrbmWZm9TO_CWMXihw9QUyuo_ 10:46:47 INFO - Expected file size: 22019689 10:46:47 INFO - Obtained file size: 22019689 10:46:51 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 10:46:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C8nwRexxSxqmfHiWzbfb4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:46:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C8nwRexxSxqmfHiWzbfb4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:46:51 INFO - Fetch https://queue.taskcluster.net/v1/task/C8nwRexxSxqmfHiWzbfb4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:46:52 INFO - Http code: 200 10:46:52 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 10:46:52 INFO - x-amz-cf-id: gE_ua1jNsZJ6ZG5TIXtcexujvelua3nsvL5oWAu6ERDPcTJ4qYuCvw== 10:46:52 INFO - x-amz-version-id: dIKYZRNPrbmWZm9TO_CWMXihw9QUyuo_ 10:46:52 INFO - Expected file size: 22019689 10:46:52 INFO - Obtained file size: 22019689 10:46:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C8nwRexxSxqmfHiWzbfb4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:46:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C8nwRexxSxqmfHiWzbfb4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:46:56 INFO - Fetch https://queue.taskcluster.net/v1/task/C8nwRexxSxqmfHiWzbfb4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:46:57 INFO - Http code: 200 10:46:57 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 10:46:57 INFO - x-amz-cf-id: w3KuTlr-jWFHnCh0ArrR2YGOQuSc4zf_6s2Ok4H3FuooSDsMjfstfA== 10:46:57 INFO - x-amz-version-id: uE.XYBe9Gj3yCqVg0OwuLItqnERM4syn 10:46:57 INFO - Expected file size: 14409038 10:46:57 INFO - Obtained file size: 14409038 10:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:46:57 INFO - trying https://queue.taskcluster.net/v1/task/C8nwRexxSxqmfHiWzbfb4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:46:57 INFO - Downloading https://queue.taskcluster.net/v1/task/C8nwRexxSxqmfHiWzbfb4g/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 10:46:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C8nwRexxSxqmfHiWzbfb4g/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 10:46:58 INFO - Downloaded 59606260 bytes. 10:46:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C8nwRexxSxqmfHiWzbfb4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:46:58 INFO - mkdir: /builds/slave/test/properties 10:46:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:46:58 INFO - Writing to file /builds/slave/test/properties/build_url 10:46:58 INFO - Contents: 10:46:58 INFO - build_url:https://queue.taskcluster.net/v1/task/C8nwRexxSxqmfHiWzbfb4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:46:59 INFO - Running post-action listener: _resource_record_post_action 10:46:59 INFO - Running post-action listener: set_extra_try_arguments 10:46:59 INFO - [mozharness: 2016-11-02 17:46:59.662398Z] Finished download-and-extract step (success) 10:46:59 INFO - [mozharness: 2016-11-02 17:46:59.662624Z] Running populate-webroot step. 10:46:59 INFO - Running pre-action listener: _resource_record_pre_action 10:46:59 INFO - Running main action method: populate_webroot 10:46:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:46:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:46:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:46:59 INFO - '--tppagecycles', 10:46:59 INFO - '7'], 10:46:59 INFO - 'tests': ['tsvgm']}}, 10:46:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:46:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:46:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:46:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:46:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:46:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:46:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:59 INFO - 'talos_options': ['--disable-e10s'], 10:46:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:46:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:46:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:59 INFO - 'talos_options': ['--disable-e10s'], 10:46:59 INFO - 'tests': ['damp', 'tps']}, 10:46:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:59 INFO - 'tests': ['damp', 'tps']}, 10:46:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:46:59 INFO - 'tests': ['dromaeo_dom']}, 10:46:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:46:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:46:59 INFO - 'tests': ['basic_compositor_video']}, 10:46:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:46:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:46:59 INFO - 'tests': ['a11yr', 10:46:59 INFO - 'ts_paint', 10:46:59 INFO - 'tpaint', 10:46:59 INFO - 'sessionrestore', 10:46:59 INFO - 'sessionrestore_no_auto_restore', 10:46:59 INFO - 'tabpaint']}, 10:46:59 INFO - 'other-e10s': {'tests': ['a11yr', 10:46:59 INFO - 'ts_paint', 10:46:59 INFO - 'tpaint', 10:46:59 INFO - 'sessionrestore', 10:46:59 INFO - 'sessionrestore_no_auto_restore', 10:46:59 INFO - 'tabpaint']}, 10:46:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:46:59 INFO - 'ts_paint', 10:46:59 INFO - 'tpaint', 10:46:59 INFO - 'sessionrestore', 10:46:59 INFO - 'sessionrestore_no_auto_restore', 10:46:59 INFO - 'tabpaint']}, 10:46:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:46:59 INFO - 'ts_paint', 10:46:59 INFO - 'tpaint', 10:46:59 INFO - 'sessionrestore', 10:46:59 INFO - 'sessionrestore_no_auto_restore', 10:46:59 INFO - 'tabpaint']}, 10:46:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:46:59 INFO - 'tests': ['a11yr', 10:46:59 INFO - 'ts_paint', 10:46:59 INFO - 'tpaint', 10:46:59 INFO - 'sessionrestore', 10:46:59 INFO - 'sessionrestore_no_auto_restore', 10:46:59 INFO - 'tabpaint']}, 10:46:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:46:59 INFO - 'tests': ['a11yr', 10:46:59 INFO - 'ts_paint', 10:46:59 INFO - 'tpaint', 10:46:59 INFO - 'sessionrestore', 10:46:59 INFO - 'sessionrestore_no_auto_restore', 10:46:59 INFO - 'tabpaint']}, 10:46:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:46:59 INFO - 'tests': ['tsvgx', 10:46:59 INFO - 'tsvgr_opacity', 10:46:59 INFO - 'tart', 10:46:59 INFO - 'tscrollx', 10:46:59 INFO - 'cart']}, 10:46:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:46:59 INFO - 'tsvgr_opacity', 10:46:59 INFO - 'tart', 10:46:59 INFO - 'tscrollx', 10:46:59 INFO - 'cart']}, 10:46:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:59 INFO - 'talos_options': ['--disable-e10s'], 10:46:59 INFO - 'tests': ['tp5o']}, 10:46:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:59 INFO - 'tests': ['tp5o']}, 10:46:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:59 INFO - 'talos_options': ['--disable-e10s', 10:46:59 INFO - '--xperf_path', 10:46:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:46:59 INFO - 'tests': ['tp5n']}, 10:46:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:59 INFO - 'talos_options': ['--xperf_path', 10:46:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:46:59 INFO - 'tests': ['tp5n']}}, 10:46:59 INFO - 'talos.zip': {'path': '', 10:46:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:46:59 INFO - Running post-action listener: _resource_record_post_action 10:46:59 INFO - [mozharness: 2016-11-02 17:46:59.685090Z] Finished populate-webroot step (success) 10:46:59 INFO - [mozharness: 2016-11-02 17:46:59.685177Z] Running create-virtualenv step. 10:46:59 INFO - Running pre-action listener: _resource_record_pre_action 10:46:59 INFO - Running main action method: create_virtualenv 10:46:59 INFO - Creating virtualenv /builds/slave/test/build/venv 10:46:59 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 10:46:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:46:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:46:59 INFO - Using real prefix '/usr' 10:46:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:47:00 INFO - Installing distribute.............................................................................................................................................................................................done. 10:47:02 INFO - Installing pip.................done. 10:47:02 INFO - Return code: 0 10:47:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:47:02 INFO - Reading from file tmpfile_stdout 10:47:02 INFO - Output received: 10:47:02 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) 10:47:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f940feb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24397b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c8790>, '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 0x24c9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c9b20>, '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': 'ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849', '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 10:47:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:47:02 INFO - Using env: {'DISPLAY': ':0', 10:47:02 INFO - 'HOME': '/home/cltbld', 10:47:02 INFO - 'LANG': 'en_US.UTF-8', 10:47:02 INFO - 'LANGUAGE': 'en_US:en', 10:47:02 INFO - 'LOGNAME': 'cltbld', 10:47:02 INFO - 'MAIL': '/var/mail/cltbld', 10:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:02 INFO - 'MOZ_NO_REMOTE': '1', 10:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:02 INFO - 'NO_EM_RESTART': '1', 10:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:02 INFO - 'PWD': '/builds/slave/test', 10:47:02 INFO - 'SHELL': '/bin/bash', 10:47:02 INFO - 'SHLVL': '1', 10:47:02 INFO - 'TERM': 'linux', 10:47:02 INFO - 'TMOUT': '86400', 10:47:02 INFO - 'USER': 'cltbld', 10:47:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849', 10:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:02 INFO - '_': '/tools/buildbot/bin/python'} 10:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:02 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 10:47:02 INFO - Cleaning up... 10:47:02 INFO - Return code: 0 10:47:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f940feb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24397b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c8790>, '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 0x24c9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c9b20>, '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': 'ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849', '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 10:47:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:47:02 INFO - Using env: {'DISPLAY': ':0', 10:47:02 INFO - 'HOME': '/home/cltbld', 10:47:02 INFO - 'LANG': 'en_US.UTF-8', 10:47:02 INFO - 'LANGUAGE': 'en_US:en', 10:47:02 INFO - 'LOGNAME': 'cltbld', 10:47:02 INFO - 'MAIL': '/var/mail/cltbld', 10:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:02 INFO - 'MOZ_NO_REMOTE': '1', 10:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:02 INFO - 'NO_EM_RESTART': '1', 10:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:02 INFO - 'PWD': '/builds/slave/test', 10:47:02 INFO - 'SHELL': '/bin/bash', 10:47:02 INFO - 'SHLVL': '1', 10:47:02 INFO - 'TERM': 'linux', 10:47:02 INFO - 'TMOUT': '86400', 10:47:02 INFO - 'USER': 'cltbld', 10:47:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849', 10:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:02 INFO - '_': '/tools/buildbot/bin/python'} 10:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:02 INFO - Downloading/unpacking psutil>=3.1.1 10:47:02 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 10:47:02 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 10:47:02 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 10:47:02 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 10:47:02 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 10:47:02 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 10:47:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:47:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:47:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:47:05 INFO - Installing collected packages: psutil 10:47:05 INFO - Running setup.py install for psutil 10:47:05 INFO - building 'psutil._psutil_linux' extension 10:47:05 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 10:47:05 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 10:47:05 INFO - building 'psutil._psutil_posix' extension 10:47:05 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 10:47:05 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 10:47:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:47:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:47:05 INFO - Successfully installed psutil 10:47:05 INFO - Cleaning up... 10:47:05 INFO - Return code: 0 10:47:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:47: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')]} 10:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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')]} 10:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f940feb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24397b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c8790>, '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 0x24c9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c9b20>, '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': 'ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849', '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 10:47: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:47: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 mozsystemmonitor==0.3 10:47:05 INFO - Using env: {'DISPLAY': ':0', 10:47:05 INFO - 'HOME': '/home/cltbld', 10:47:05 INFO - 'LANG': 'en_US.UTF-8', 10:47:05 INFO - 'LANGUAGE': 'en_US:en', 10:47:05 INFO - 'LOGNAME': 'cltbld', 10:47:05 INFO - 'MAIL': '/var/mail/cltbld', 10:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:05 INFO - 'MOZ_NO_REMOTE': '1', 10:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:05 INFO - 'NO_EM_RESTART': '1', 10:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:05 INFO - 'PWD': '/builds/slave/test', 10:47:05 INFO - 'SHELL': '/bin/bash', 10:47:05 INFO - 'SHLVL': '1', 10:47:05 INFO - 'TERM': 'linux', 10:47:05 INFO - 'TMOUT': '86400', 10:47:05 INFO - 'USER': 'cltbld', 10:47:05 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849', 10:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:05 INFO - '_': '/tools/buildbot/bin/python'} 10:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:47:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:47:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:47:07 INFO - Installing collected packages: mozsystemmonitor 10:47:07 INFO - Running setup.py install for mozsystemmonitor 10:47:07 INFO - Successfully installed mozsystemmonitor 10:47:07 INFO - Cleaning up... 10:47:07 INFO - Return code: 0 10:47:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f940feb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24397b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c8790>, '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 0x24c9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c9b20>, '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': 'ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849', '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 10:47:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:47:07 INFO - Using env: {'DISPLAY': ':0', 10:47:07 INFO - 'HOME': '/home/cltbld', 10:47:07 INFO - 'LANG': 'en_US.UTF-8', 10:47:07 INFO - 'LANGUAGE': 'en_US:en', 10:47:07 INFO - 'LOGNAME': 'cltbld', 10:47:07 INFO - 'MAIL': '/var/mail/cltbld', 10:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:07 INFO - 'MOZ_NO_REMOTE': '1', 10:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:07 INFO - 'NO_EM_RESTART': '1', 10:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:07 INFO - 'PWD': '/builds/slave/test', 10:47:07 INFO - 'SHELL': '/bin/bash', 10:47:07 INFO - 'SHLVL': '1', 10:47:07 INFO - 'TERM': 'linux', 10:47:07 INFO - 'TMOUT': '86400', 10:47:07 INFO - 'USER': 'cltbld', 10:47:07 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849', 10:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:07 INFO - '_': '/tools/buildbot/bin/python'} 10:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:08 INFO - Downloading/unpacking jsonschema==2.5.1 10:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:47:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:10 INFO - Downloading functools32-3.2.3-2.tar.gz 10:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:47:10 INFO - warning: no files found matching '*.txt' 10:47:10 INFO - no previously-included directories found matching 'build' 10:47:10 INFO - no previously-included directories found matching 'dist' 10:47:10 INFO - no previously-included directories found matching '.git*' 10:47:10 INFO - Installing collected packages: jsonschema, functools32 10:47:10 INFO - Running setup.py install for functools32 10:47:10 INFO - warning: no files found matching '*.txt' 10:47:10 INFO - no previously-included directories found matching 'build' 10:47:10 INFO - no previously-included directories found matching 'dist' 10:47:10 INFO - no previously-included directories found matching '.git*' 10:47:10 INFO - Successfully installed jsonschema functools32 10:47:10 INFO - Cleaning up... 10:47:10 INFO - Return code: 0 10:47:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:10 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 0x7f940feb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24397b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c8790>, '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 0x24c9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c9b20>, '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': 'ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849', '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 10:47:10 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 10:47:10 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 10:47:10 INFO - Using env: {'DISPLAY': ':0', 10:47:10 INFO - 'HOME': '/home/cltbld', 10:47:10 INFO - 'LANG': 'en_US.UTF-8', 10:47:10 INFO - 'LANGUAGE': 'en_US:en', 10:47:10 INFO - 'LOGNAME': 'cltbld', 10:47:10 INFO - 'MAIL': '/var/mail/cltbld', 10:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:10 INFO - 'MOZ_NO_REMOTE': '1', 10:47:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:10 INFO - 'NO_EM_RESTART': '1', 10:47:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:10 INFO - 'PWD': '/builds/slave/test', 10:47:10 INFO - 'SHELL': '/bin/bash', 10:47:10 INFO - 'SHLVL': '1', 10:47:10 INFO - 'TERM': 'linux', 10:47:10 INFO - 'TMOUT': '86400', 10:47:10 INFO - 'USER': 'cltbld', 10:47:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849', 10:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:10 INFO - '_': '/tools/buildbot/bin/python'} 10:47:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:47:10 INFO - Cleaning up... 10:47:10 INFO - Return code: 0 10:47:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:10 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 0x7f940feb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24397b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c8790>, '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 0x24c9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c9b20>, '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': 'ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849', '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 10:47:10 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 10:47:10 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 10:47:10 INFO - Using env: {'DISPLAY': ':0', 10:47:10 INFO - 'HOME': '/home/cltbld', 10:47:10 INFO - 'LANG': 'en_US.UTF-8', 10:47:10 INFO - 'LANGUAGE': 'en_US:en', 10:47:10 INFO - 'LOGNAME': 'cltbld', 10:47:10 INFO - 'MAIL': '/var/mail/cltbld', 10:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:10 INFO - 'MOZ_NO_REMOTE': '1', 10:47:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:10 INFO - 'NO_EM_RESTART': '1', 10:47:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:10 INFO - 'PWD': '/builds/slave/test', 10:47:10 INFO - 'SHELL': '/bin/bash', 10:47:10 INFO - 'SHLVL': '1', 10:47:10 INFO - 'TERM': 'linux', 10:47:10 INFO - 'TMOUT': '86400', 10:47:10 INFO - 'USER': 'cltbld', 10:47:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849', 10:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:10 INFO - '_': '/tools/buildbot/bin/python'} 10:47:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:10 INFO - Downloading/unpacking blobuploader==1.2.4 10:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:12 INFO - Downloading blobuploader-1.2.4.tar.gz 10:47:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:47:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:47:12 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 10:47:12 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 10:47:12 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 10:47:12 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 10:47:12 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 10:47:12 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 10:47:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:47:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47:13 INFO - Downloading docopt-0.6.1.tar.gz 10:47:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:47:13 INFO - Installing collected packages: blobuploader, requests, docopt 10:47:13 INFO - Running setup.py install for blobuploader 10:47:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:47:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:47:13 INFO - Running setup.py install for requests 10:47:14 INFO - Running setup.py install for docopt 10:47:14 INFO - Successfully installed blobuploader requests docopt 10:47:14 INFO - Cleaning up... 10:47:14 INFO - Return code: 0 10:47:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47: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')]} 10:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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')]} 10:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:14 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 0x7f940feb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24397b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c8790>, '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 0x24c9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c9b20>, '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': 'ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849', '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 10:47:14 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 10:47:14 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 10:47:14 INFO - Using env: {'DISPLAY': ':0', 10:47:14 INFO - 'HOME': '/home/cltbld', 10:47:14 INFO - 'LANG': 'en_US.UTF-8', 10:47:14 INFO - 'LANGUAGE': 'en_US:en', 10:47:14 INFO - 'LOGNAME': 'cltbld', 10:47:14 INFO - 'MAIL': '/var/mail/cltbld', 10:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:14 INFO - 'MOZ_NO_REMOTE': '1', 10:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:14 INFO - 'NO_EM_RESTART': '1', 10:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:14 INFO - 'PWD': '/builds/slave/test', 10:47:14 INFO - 'SHELL': '/bin/bash', 10:47:14 INFO - 'SHLVL': '1', 10:47:14 INFO - 'TERM': 'linux', 10:47:14 INFO - 'TMOUT': '86400', 10:47:14 INFO - 'USER': 'cltbld', 10:47:14 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849', 10:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:14 INFO - '_': '/tools/buildbot/bin/python'} 10:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:47:14 INFO - Running setup.py (path:/tmp/pip-qtK6nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:47:14 INFO - Running setup.py (path:/tmp/pip-ZhMh76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:47:14 INFO - Running setup.py (path:/tmp/pip-gSQitF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:47:14 INFO - Running setup.py (path:/tmp/pip-3TZEzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:47:14 INFO - Running setup.py (path:/tmp/pip-A1EoF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:47:14 INFO - Running setup.py (path:/tmp/pip-Jx6BS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:47:14 INFO - Running setup.py (path:/tmp/pip-r1qp_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:47:15 INFO - Running setup.py (path:/tmp/pip-zrpATU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:47:15 INFO - Running setup.py (path:/tmp/pip-LYd9hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:47:15 INFO - Running setup.py (path:/tmp/pip-cyU_Jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:47:15 INFO - Running setup.py (path:/tmp/pip-dSdWqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:47:15 INFO - Running setup.py (path:/tmp/pip-qu1iFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:47:15 INFO - Running setup.py (path:/tmp/pip-p4Yd1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:47:15 INFO - Running setup.py (path:/tmp/pip-JfdFqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:15 INFO - Running setup.py (path:/tmp/pip-PSn_BN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:47:15 INFO - Running setup.py (path:/tmp/pip-SkfZyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:47:15 INFO - Running setup.py (path:/tmp/pip-hqDjte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:47:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:47:15 INFO - Running setup.py install for manifestparser 10:47:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:47:15 INFO - Running setup.py install for mozcrash 10:47:15 INFO - Running setup.py install for mozdebug 10:47:16 INFO - Running setup.py install for mozdevice 10:47:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:47:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:47:16 INFO - Running setup.py install for mozfile 10:47:16 INFO - Running setup.py install for mozhttpd 10:47:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:47:16 INFO - Running setup.py install for mozinfo 10:47:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:47:16 INFO - Running setup.py install for mozInstall 10:47:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:47:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:47:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:47:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:47:16 INFO - Running setup.py install for mozleak 10:47:16 INFO - Running setup.py install for mozlog 10:47:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:47:16 INFO - Running setup.py install for moznetwork 10:47:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:47:16 INFO - Running setup.py install for mozprocess 10:47:16 INFO - Running setup.py install for mozprofile 10:47:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:47:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:47:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:47:17 INFO - Running setup.py install for mozrunner 10:47:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:47:17 INFO - Running setup.py install for mozscreenshot 10:47:17 INFO - Running setup.py install for moztest 10:47:17 INFO - Running setup.py install for mozversion 10:47:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:47:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:47:17 INFO - Cleaning up... 10:47:17 INFO - Return code: 0 10:47:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47: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')]} 10:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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')]} 10:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:17 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 0x7f940feb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24397b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c8790>, '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 0x24c9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c9b20>, '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': 'ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849', '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 10:47:17 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 10:47:17 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 10:47:17 INFO - Using env: {'DISPLAY': ':0', 10:47:17 INFO - 'HOME': '/home/cltbld', 10:47:17 INFO - 'LANG': 'en_US.UTF-8', 10:47:17 INFO - 'LANGUAGE': 'en_US:en', 10:47:17 INFO - 'LOGNAME': 'cltbld', 10:47:17 INFO - 'MAIL': '/var/mail/cltbld', 10:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:17 INFO - 'MOZ_NO_REMOTE': '1', 10:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:17 INFO - 'NO_EM_RESTART': '1', 10:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:17 INFO - 'PWD': '/builds/slave/test', 10:47:17 INFO - 'SHELL': '/bin/bash', 10:47:17 INFO - 'SHLVL': '1', 10:47:17 INFO - 'TERM': 'linux', 10:47:17 INFO - 'TMOUT': '86400', 10:47:17 INFO - 'USER': 'cltbld', 10:47:17 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849', 10:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:17 INFO - '_': '/tools/buildbot/bin/python'} 10:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:47:17 INFO - Running setup.py (path:/tmp/pip-ZwrK7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:47:17 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)) 10:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:47:17 INFO - Running setup.py (path:/tmp/pip-Kg8YPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:47:17 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)) 10:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:47:17 INFO - Running setup.py (path:/tmp/pip-QgePWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:47:17 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)) 10:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:47:17 INFO - Running setup.py (path:/tmp/pip-KwheYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:47:18 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)) 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:47:18 INFO - Running setup.py (path:/tmp/pip-_j3Av7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:47:18 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)) 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:47:18 INFO - Running setup.py (path:/tmp/pip-3myuIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:47:18 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)) 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:47:18 INFO - Running setup.py (path:/tmp/pip-Ft82DL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:47:18 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)) 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:47:18 INFO - Running setup.py (path:/tmp/pip-axXQZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:47:18 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)) 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:47:18 INFO - Running setup.py (path:/tmp/pip-pgGVYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:47:18 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)) 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:47:18 INFO - Running setup.py (path:/tmp/pip-cu4F9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:47:18 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)) 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:47:18 INFO - Running setup.py (path:/tmp/pip-tI7X1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:47:18 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)) 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:47:18 INFO - Running setup.py (path:/tmp/pip-fFKdni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:47:18 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)) 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:47:18 INFO - Running setup.py (path:/tmp/pip-IiabbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:47:18 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)) 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:47:18 INFO - Running setup.py (path:/tmp/pip-nDvy82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:47:18 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)) 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:18 INFO - Running setup.py (path:/tmp/pip-ULeOOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:18 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)) 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:47:18 INFO - Running setup.py (path:/tmp/pip-udEBET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:47:18 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)) 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:47:18 INFO - Running setup.py (path:/tmp/pip-S5NBjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:47:19 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)) 10:47:19 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)) 10:47:19 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)) 10:47:19 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)) 10:47:19 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)) 10:47:19 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)) 10:47:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:47:19 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 10:47:19 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 10:47:19 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 10:47:19 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 10:47:19 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 10:47:19 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 10:47:20 INFO - Downloading blessings-1.6.tar.gz 10:47:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:47:21 INFO - Installing collected packages: blessings 10:47:21 INFO - Running setup.py install for blessings 10:47:21 INFO - Successfully installed blessings 10:47:21 INFO - Cleaning up... 10:47:21 INFO - Return code: 0 10:47:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:47:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:47:21 INFO - Reading from file tmpfile_stdout 10:47:21 INFO - Current package versions: 10:47:21 INFO - argparse == 1.2.1 10:47:21 INFO - blessings == 1.6 10:47:21 INFO - blobuploader == 1.2.4 10:47:21 INFO - docopt == 0.6.1 10:47:21 INFO - functools32 == 3.2.3-2 10:47:21 INFO - jsonschema == 2.5.1 10:47:21 INFO - manifestparser == 1.1 10:47:21 INFO - mozInstall == 1.12 10:47:21 INFO - mozcrash == 0.17 10:47:21 INFO - mozdebug == 0.1 10:47:21 INFO - mozdevice == 0.48 10:47:21 INFO - mozfile == 1.2 10:47:21 INFO - mozhttpd == 0.7 10:47:21 INFO - mozinfo == 0.9 10:47:21 INFO - mozleak == 0.1 10:47:21 INFO - mozlog == 3.4 10:47:21 INFO - moznetwork == 0.27 10:47:21 INFO - mozprocess == 0.23 10:47:21 INFO - mozprofile == 0.28 10:47:21 INFO - mozrunner == 6.12 10:47:21 INFO - mozscreenshot == 0.1 10:47:21 INFO - mozsystemmonitor == 0.3 10:47:21 INFO - moztest == 0.7 10:47:21 INFO - mozversion == 1.4 10:47:21 INFO - psutil == 3.1.1 10:47:21 INFO - requests == 1.2.3 10:47:21 INFO - wsgiref == 0.1.2 10:47:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47:21 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')]} 10:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:21 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')]} 10:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:21 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 0x7f940feb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24397b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c8790>, '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 0x24c9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c9b20>, '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': 'ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849', '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 10:47:21 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 10:47:21 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 10:47:21 INFO - Using env: {'DISPLAY': ':0', 10:47:21 INFO - 'HOME': '/home/cltbld', 10:47:21 INFO - 'LANG': 'en_US.UTF-8', 10:47:21 INFO - 'LANGUAGE': 'en_US:en', 10:47:21 INFO - 'LOGNAME': 'cltbld', 10:47:21 INFO - 'MAIL': '/var/mail/cltbld', 10:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:21 INFO - 'MOZ_NO_REMOTE': '1', 10:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:21 INFO - 'NO_EM_RESTART': '1', 10:47:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:21 INFO - 'PWD': '/builds/slave/test', 10:47:21 INFO - 'SHELL': '/bin/bash', 10:47:21 INFO - 'SHLVL': '1', 10:47:21 INFO - 'TERM': 'linux', 10:47:21 INFO - 'TMOUT': '86400', 10:47:21 INFO - 'USER': 'cltbld', 10:47:21 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849', 10:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:21 INFO - '_': '/tools/buildbot/bin/python'} 10:47:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:21 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)) 10:47:21 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)) 10:47:21 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)) 10:47:21 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)) 10:47:21 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)) 10:47:21 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)) 10:47:21 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)) 10:47:21 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)) 10:47:21 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)) 10:47:21 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)) 10:47:21 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)) 10:47:21 INFO - Cleaning up... 10:47:21 INFO - Return code: 0 10:47:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:47:21 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')]} 10:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:21 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')]} 10:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:21 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 0x7f940feb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24397b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c8790>, '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 0x24c9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c9b20>, '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': 'ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849', '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 10:47:21 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 10:47:21 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 10:47:21 INFO - Using env: {'DISPLAY': ':0', 10:47:21 INFO - 'HOME': '/home/cltbld', 10:47:21 INFO - 'LANG': 'en_US.UTF-8', 10:47:21 INFO - 'LANGUAGE': 'en_US:en', 10:47:21 INFO - 'LOGNAME': 'cltbld', 10:47:21 INFO - 'MAIL': '/var/mail/cltbld', 10:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:21 INFO - 'MOZ_NO_REMOTE': '1', 10:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:21 INFO - 'NO_EM_RESTART': '1', 10:47:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:21 INFO - 'PWD': '/builds/slave/test', 10:47:21 INFO - 'SHELL': '/bin/bash', 10:47:21 INFO - 'SHLVL': '1', 10:47:21 INFO - 'TERM': 'linux', 10:47:21 INFO - 'TMOUT': '86400', 10:47:21 INFO - 'USER': 'cltbld', 10:47:21 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849', 10:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:21 INFO - '_': '/tools/buildbot/bin/python'} 10:47:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:47:21 INFO - Cleaning up... 10:47:21 INFO - Return code: 0 10:47:21 INFO - Running post-action listener: _resource_record_post_action 10:47:21 INFO - Running post-action listener: _start_resource_monitoring 10:47:21 INFO - Starting resource monitoring. 10:47:21 INFO - [mozharness: 2016-11-02 17:47:21.906056Z] Finished create-virtualenv step (success) 10:47:21 INFO - [mozharness: 2016-11-02 17:47:21.906570Z] Running install step. 10:47:21 INFO - Running pre-action listener: _resource_record_pre_action 10:47:21 INFO - Running main action method: install 10:47:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:47:22 INFO - Reading from file tmpfile_stdout 10:47:22 INFO - Detecting whether we're running mozinstall >=1.0... 10:47:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:47:22 INFO - Reading from file tmpfile_stdout 10:47:22 INFO - Output received: 10:47:22 INFO - Usage: mozinstall [options] installer 10:47:22 INFO - Options: 10:47:22 INFO - -h, --help show this help message and exit 10:47:22 INFO - -d DEST, --destination=DEST 10:47:22 INFO - Directory to install application into. [default: 10:47:22 INFO - "/builds/slave/test"] 10:47:22 INFO - --app=APP Application being installed. [default: firefox] 10:47:22 INFO - mkdir: /builds/slave/test/build/application 10:47:22 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'] 10:47:22 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 10:47:39 INFO - Reading from file tmpfile_stdout 10:47:39 INFO - Output received: 10:47:39 INFO - /builds/slave/test/build/application/firefox/firefox 10:47:39 INFO - Running post-action listener: _resource_record_post_action 10:47:39 INFO - [mozharness: 2016-11-02 17:47:39.164799Z] Finished install step (success) 10:47:39 INFO - [mozharness: 2016-11-02 17:47:39.165042Z] Running run-tests step. 10:47:39 INFO - Running pre-action listener: _resource_record_pre_action 10:47:39 INFO - Running main action method: run_tests 10:47:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:47:39 INFO - Python 2.7.3 10:47:39 INFO - Return code: 0 10:47:39 INFO - grabbing minidump binary from tooltool 10:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:39 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 0x24c8790>, '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 0x24c9690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:47:39 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 10:47:39 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 10:47:39 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 10:47:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:47:39 INFO - Return code: 0 10:47:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:47:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:47:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:47:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:47:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:47:39 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/C8nwRexxSxqmfHiWzbfb4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 10:47:39 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/C8nwRexxSxqmfHiWzbfb4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 10:47:39 INFO - Using env: {'DISPLAY': ':0', 10:47:39 INFO - 'HOME': '/home/cltbld', 10:47:39 INFO - 'LANG': 'en_US.UTF-8', 10:47:39 INFO - 'LANGUAGE': 'en_US:en', 10:47:39 INFO - 'LOGNAME': 'cltbld', 10:47:39 INFO - 'MAIL': '/var/mail/cltbld', 10:47:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:47:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:39 INFO - 'MOZ_NO_REMOTE': '1', 10:47:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:47:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:39 INFO - 'NO_EM_RESTART': '1', 10:47:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:39 INFO - 'PWD': '/builds/slave/test', 10:47:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:47:39 INFO - 'SHELL': '/bin/bash', 10:47:39 INFO - 'SHLVL': '1', 10:47:39 INFO - 'TERM': 'linux', 10:47:39 INFO - 'TMOUT': '86400', 10:47:39 INFO - 'USER': 'cltbld', 10:47:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849', 10:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:39 INFO - '_': '/tools/buildbot/bin/python'} 10:47:39 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/C8nwRexxSxqmfHiWzbfb4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 10:47:39 INFO - mozversion application_buildid: 20161102073203 10:47:39 INFO - mozversion application_changeset: 3bfde35a0d18a643485ffd5073f3bc6a79e0ae48 10:47:39 INFO - mozversion application_display_name: Nightly 10:47:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:47:39 INFO - mozversion application_name: Firefox 10:47:39 INFO - mozversion application_remotingname: firefox 10:47:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:47:39 INFO - mozversion application_vendor: Mozilla 10:47:39 INFO - mozversion application_version: 52.0a1 10:47:39 INFO - mozversion platform_buildid: 20161102073203 10:47:39 INFO - mozversion platform_changeset: 3bfde35a0d18a643485ffd5073f3bc6a79e0ae48 10:47:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:47:39 INFO - mozversion platform_version: 52.0a1 10:47:39 INFO - using testdate: 1478108859 10:47:39 INFO - actual date: 1478108859 10:47:39 INFO - starting webserver on 'localhost:38825' 10:47:39 INFO - SUITE-START | Running 2 tests 10:47:39 INFO - TEST-START | dromaeo_css 10:47:39 INFO - operating with platform_type : linux_ 10:47:39 INFO - Initialising browser for dromaeo_css test... 10:47:39 INFO - TEST-INFO | started process 4953 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFWJaBn/profile http://localhost:38825/getInfo.html) 10:47:43 INFO - PROCESS | 4953 | __metrics Screen width/height:1600/1200 10:47:43 INFO - PROCESS | 4953 | colorDepth:24 10:47:43 INFO - PROCESS | 4953 | Browser inner width/height: 1024/697 10:47:43 INFO - PROCESS | 4953 | __metrics 10:47:43 INFO - PROCESS | 4953 | 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" 10:47:43 INFO - PROCESS | 4953 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:47:44 INFO - PROCESS | 4953 | console.error: PushService: 10:47:44 INFO - PROCESS | 4953 | stateChangeProcessEnqueue: Error transitioning state 10:47:44 INFO - PROCESS | 4953 | UnknownError 10:47:45 INFO - TEST-INFO | 4953: exit 0 10:47:45 INFO - Browser initialized. 10:47:45 INFO - Running cycle 1/1 for dromaeo_css test... 10:47:45 INFO - TEST-INFO | started process 5035 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFWJaBn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:47:57 INFO - PROCESS | 5035 | RSS: Main: 172535808 10:47:57 INFO - PROCESS | 5035 | 10:48:48 INFO - PROCESS | 5035 | 1478108928751 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] 10:50:59 INFO - PROCESS | 5035 | Cycle 1(1): loaded http://localhost:38825/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38825/tests/dromaeo/cssquery-ext.html) 10:51:00 INFO - PROCESS | 5035 | RSS: Main: 303857664 10:51:00 INFO - PROCESS | 5035 | 10:54:02 INFO - PROCESS | 5035 | Cycle 1(1): loaded http://localhost:38825/tests/dromaeo/cssquery-ext.html (next: http://localhost:38825/tests/dromaeo/cssquery-jquery.html) 10:54:03 INFO - PROCESS | 5035 | RSS: Main: 278499328 10:54:03 INFO - PROCESS | 5035 | 10:57:05 INFO - PROCESS | 5035 | Cycle 1(1): loaded http://localhost:38825/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38825/tests/dromaeo/cssquery-mootools.html) 10:57:06 INFO - PROCESS | 5035 | RSS: Main: 215085056 10:57:06 INFO - PROCESS | 5035 | 11:00:08 INFO - PROCESS | 5035 | Cycle 1(1): loaded http://localhost:38825/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38825/tests/dromaeo/cssquery-prototype.html) 11:00:08 INFO - PROCESS | 5035 | RSS: Main: 253362176 11:00:08 INFO - PROCESS | 5035 | 11:03:11 INFO - PROCESS | 5035 | Cycle 1(1): loaded http://localhost:38825/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38825/tests/dromaeo/cssquery-yui.html) 11:03:12 INFO - PROCESS | 5035 | RSS: Main: 216199168 11:03:12 INFO - PROCESS | 5035 | 11:06:14 INFO - PROCESS | 5035 | Cycle 1(1): loaded http://localhost:38825/tests/dromaeo/cssquery-yui.html (next: http://localhost:38825/tests/dromaeo/cssquery-dojo.html) 11:06:15 INFO - PROCESS | 5035 | RSS: Main: 316801024 11:06:15 INFO - PROCESS | 5035 | 11:06:15 INFO - PROCESS | 5035 | __start_tp_report 11:06:15 INFO - PROCESS | 5035 | _x_x_mozilla_page_load 11:06:15 INFO - PROCESS | 5035 | _x_x_mozilla_page_load_details 11:06:15 INFO - PROCESS | 5035 | |i|pagename|runs| 11:06:15 INFO - PROCESS | 5035 | |0;dojo.html;3042.345895632439;3084.9228769280767;3089.459344614693;3113.2372568720666;3139.9215019624507;5349.411564727887;5381.973090134544;5433.239346491489;5494.752736126874;5495.560355171581;5429;5456.727163641822;5510.669359838413;5524.033294173523;5615.129654903497;4926.876828079291;4960.702357858522;5039.168537191359;5056.469070747574;5068.087744206042;4938.7530623468865;4945.159322915113;4986.626003049768;5008.198688209887;5035.62232832539;5024.497550244964;5042.924356134661;5044.596432285409;5084.4661310562415;5093.541581257686;4797.544233297866;4840.370751802278;4843.685160464559;5002.52476014778;5066.16408292635;4855.247436647325;4856.781444834991;4863.489333619955;4874.8537543873745;4895.0944075345815;5356.892862142774;5365.114756065244;5369.597280203961;5384.273123128367;5440.183972404171;5758.971205143989;5760.654360738369;5761.107028410603;5765.596408251424;5770.6249093808765;5627.043402621564;5671.546276297928;5800.129980502916;5851.882962340772;5883;5487.341519017744;5488.204210389511;5494.395616482184;5494.642848214853;5551.333839939192;5948.524118070544;6016.488598469092;6024.457798798129;6024.638521688713;6025.276966763929;5481.040817856939;5517.61376703635;5594.9929012777275;5636.379998200195;5751.223584815996;5698.373178950312;5740.425957404226;5741.655500669973;5780.797672081457;5793.710314484259;5714.399988001283;5716.742746576414;5717.656940583495;5721.656700597978;5723.055695810144;5557.861053473695;5568.6658800472105;5616.606837521416;5733.713314334266;5791.971040144772;4453.688241823042;4478.2610869206865;4478.865634030984;4493.5281795411665;4535.387722657399;3955.6044395560216;3956.7823769692945;3966.4050392440786;4005;4018.3972404139613;5142;5487.807926722546;5489.972550137224;5494.642848214853;5499.367572729107;5584.832455026356;5739.167820666064;5749.88500229993;5787.913181302284;5848.912266316009;5413.485718856702;5425.321834770653;5434.130539113723;5434.809781657623;5439.075357189287;5036;5040.445550989388;5042.168042272984;5045.772940217699;5092.898142037213;5771.85570360736;5901.232839730807;5919.852003699942;5978.133170690313;5984.551158663205;5811.186433899173;5815.0405183146;5816.069428891357;5816.70916454184;5865.618734782225;5921.519620094976;5964.671943043;5968.701564921824;5975.16347711312;5976.163337132892;5540.390557038642;5583.190437386637;5635.549156067586;5639.210510528611;5677.205191273308;5793.217915581343;5794.710264486843;5800.216970709069;5843.766249349978;5866.6186697864505;5640.746166422438;5692.8576785579035;5693.971530142323;5694.288213973254;5708.143778433268;5495.230667706444;5531.03206938776;5642.971785141212;5662.546996240373;5681.375048744718;5677.120046392815;5704.172894930129;5705.828825135252;5751.971240143773;5772;5705.62913410627;5764.942350576441;5767.653940763567;5769.278840144982;5771.163181338767;5354.812581559782;5355.732213389237;5379.1393377059485;5432.565394768488;5435.701036443033 11:06:15 INFO - PROCESS | 5035 | |1;ext.html;557.6007460855053;576.8730879206573;591.21663795471;591.3317950715691;606.166521033579;31081.689183108192;43237;43970.340444893314;44002.779986100024;44207.33688994667;43520.782396087976;43759.78120109403;43932.341014884805;43941.340879886826;44010.33984490227;8029.718959836407;8753.212210901018;8922.197002269795;8931.95534022329;8933.731988040368;7823.178566250519;10545.367277963309;10804.621838235664;10817;11164.218504704673;10809.081228095582;10831.187660925423;10868.510917008714;10869.510872010738;10871.402072885989;8183.222593853575;8431.873521897176;10804.513796879159;10869.510872010778;10878;8175.63209655567;8240.423170378075;10284.588616455407;10661.147108231324;10674.73313167177;42157.367639485434;42385;42414.1517169658;42516;42548;3543.8050907200095;3578.964210357889;3871.5354157500997;4008.6793056555407;4048.7124774502313;29890.40219195604;31159.376812463623;31477.213069673213;31704.841475792706;32214.355712885612;4272.807723652443;4286.87139385819;4326.6754993375625;4383.035732138925;4464.263396539567;331693;331934;331947;333440;333659;56422;56722.43277567172;56758.71620641871;56795;56845.43154568401;58609.70695146582;58698.140843944006;58863.41136588665;58906.41093589095;58908.705456472446;16447.506574802774;16585;16666.83333166677;16773;16776.328946842234;11265.943670281596;11397.487113079931;11889.583864564698;11984.101192410604;12314.50741970329;15837.366505339887;16361.509154725378;16400.83599163993;16414.917925410537;16425.753613695804;6177.4749146322165;6475.32009139043;6529.15121034272;6595.340465953463;6603.669816509156;935.2845073518764;1023.8003589300015;1039.1219419590434;1042.7341028037802;1050.4275170032352;29811.850940745157;29818.55272170919;29867.40265194684;29985.40029199404;30501;1067.3595842494442;1102.366139469808;1113.1373185781085;1178.2753606531921;1185.4428418643224;15029.849701503064;15833.366665333488;15926.442574509836;16087.517374478784;16257.451954178738;454216;456742;457891;460768;461106;55175.724121379135;55827.720861395435;55963.720181398836;56026.71986640041;56034.35776674503;1303.9348032598332;1314.3231235913513;1370.465518447806;1371.7119404924879;1373.0663149058537;29718;30738.754023103396;30820.383592328475;31476;31776;50665.74667126641;50966.999999998516;51092.23361649504;51125.488745112074;51210;416250;417216;417250;418644;419584;39848.203035939696;40629.59370406258;41346.379804303564;41495.792521037205;41497.37753933754;36983.26033479369;42734.78632606817;45520.54479455295;45671.54328456673;45963;38699.6130038696;39772.534543821785;39981.2003759929;40026.59973400229;41234.79382603068;39292.60707392889;39312;39662.801685991384;40621.79689101536;41114.79442602887;39452.605473944895;39973.80013099916;40359.192816142924;40395.59604404036;40408.19183616252;33428.33143337071;34922;35446.46830297496;36071.27857442784;36112.09719757027;25812.22563323103;26438.339041524116;26485.205443836716;26485.85550008739;26553.336166595218 11:06:15 INFO - PROCESS | 5035 | |2;jquery.html;392.458407397791;393.6693177730706;401.67865707434055;404.38937204820724;419.5112693711826;13946.999999999975;17188.226529806157;17911.820881791176;19376.515587110312;19389.224431022776;15345;17124.914375428107;18238.84053937185;18288.451346459628;18768;5480.068388373976;5665.745041473123;5666.603337766358;5677.829665110054;5692.57305702072;5505.421930697279;5522.751476183561;5606.691631960241;5616;5616.887662246752;5680.687562184078;5826.300843898738;5832.445917637839;5838.5329173666005;5841.912371314434;5518.420565840609;5572.9968605650965;5575.749091290882;5640.04119299718;5695.430456954313;5446.455354464561;5448.673079615236;5451.100568406208;5453.727313634303;5458.5087342139;13444.126131801402;13539;13575.660608484768;13624.795628065587;19952.70307430027;2192.8355373346903;2256.345659758668;2293.0598454633687;2353.882305884699;2537.4328494685055;9693.369930954465;10014.799704005953;10169.084782369622;10193.439360835151;10223.437710925897;1842.2958763144172;1959.823615874578;1979.158857485563;2023.8886861222627;2120.9575808483896;75820;76830.61584692041;79639.60180199062;81392.59303703443;82792;9854;10073.748156296151;10113.94943025295;10235.692929212135;10449.738756531147;14008.299585020708;14120.788188177186;14199.29003549839;14202.857971420153;14221.217833019284;7126.251743566954;7452.105747310249;7588.203238659971;7684.231576842383;8039.839203215903;7801.517711634771;7812.3750099993;8044.195580442026;8159;8204.302634276153;4343.087951530151;4444.866654000385;4501.842435514807;4578.473475550288;4593;1742.2943707798363;1772.1582248431891;1779.7953235377838;1821.0013512907155;1846.8891866488054;837.9078301386843;927.3832901120679;928.5125309212717;1022.7801022780138;1039.823230050878;16984.32062717502;17953.281868725106;18028.098595070456;18205.505777822094;18374.81625183731;925.7361651929168;962.7400601837464;980.6371642492323;994.264244459095;1000.3347773730533;9529.761755956157;10130.797384052277;10173.54219060144;10241;10369.585216591251;146718;488941;489749;489840;506369;79672;101925.49037254915;103048;104270.47864760627;104273;1008.4403156248353;1050.5430137890041;1052.8157572424948;1059.5073290919606;1063.409807556798;16554.17229138514;16670.583235418726;17193.484195474157;17279.3952211672;17318.5670358237;39021.80489097536;39977.80011099926;40592.39111413272;41159.7942010288;41584.58415415928;41909.58090419057;49398;55153;58359.416405837095;61054.38945610487;7792.766217013499;8212.425130240827;8382.245597896219;8421.368397370099;8909.064548222603;10024.548895299875;12402.441890114786;12526.49894004266;12543.87456125427;12650.810237846255;11221.55113795439;11278.548858045915;11312.20814542974;11575.536978521102;11672.066234701373;10538.262321637412;10615.628453004108;10702.518386672462;11180.608678696206;11361.091112711129;11218.887811121784;11347.773044539228;11350.375729334966;11367.374794386387;12037.097217708882;8112.797180070545;8212.589370531568;8264.628091736007;8501.829963400822;8715.52064636451;9911.504424778876;10947.890521095005;11204.719882003015;11332.886671133183;11628.6511404658 11:06:15 INFO - PROCESS | 5035 | |3;mootools.html;1458.2052781234222;1491.2692780537536;1589.9364025438983;1734.523006173303;1746.799118101418;7423.5545867247865;7693.192214817447;8150.877736833945;8661.393702440824;8705.477671339717;8212.219839115274;8439.662413503453;8455.661773529067;8670.046294907572;8682.826343473143;2314.780095890888;2348.095983046522;2348.295511346598;2349.0721165139844;2349.2247558305717;2055.2601063617085;2108.8523803333696;2345.061975209921;2358.3278765551822;2429.356220601533;2292.9541409171807;2373.857568545884;2377.5958087125146;2381.4403615150427;2382.2257766225957;2334.9066037358484;2354.799842013431;2358.705161854768;2366.1363602285214;2388.068653225235;2369.8104151668;2380.3811009137576;2393.6648869158157;2396.077510158584;2414.9758502414925;8667.436616619963;8726.345524085718;8733.388662793606;8769.824603507894;8774.473531588124;5176.327077479904;5332.840014799563;5334.733263336856;5336.146216605363;5348.358197016383;3329.4839299908313;3465.792052476834;3602.4596310553366;3605.855765769366;3726.8695595654294;1078.8543546621183;1092.5192915117402;1110.9444527773578;1113.4899453519902;1138.601489478684;12010.579629712918;12018.759624807542;12033.57882474118;12052.216605920587;12060.698482537919;4394;4634.397528321364;4722.598579120745;4771.403574553181;4780.689255198401;9984.051515106054;9993.750156246007;10091.899081009096;10094.747631309128;10095.798084038279;5344.973275133677;5345.3852806926925;5347.171188465794;5348.572114230852;5352.304200453994;4716.245400735866;4768.880777980509;4836.637252206098;4933.28467372229;4940.1601727706375;3853.4412510185866;3870.1098747288283;3909.7458665186673;3957.940630890539;3984.183242435294;1169.0705888818409;1196.4675719305;1240.584404224595;1251.1992324912064;1280.7246442015012;797.4099166616662;897.1970086772302;900.2392977933636;914.92680585553;920.1626519867023;5377.4084850666395;5452.59105567084;5467.808626698126;5601.159826026129;5618.91571626426;970.1123472023161;986.2849434160177;1005.1154983614373;1038.4765020999046;1070.208046045936;3714.6285371462636;3731.589525152231;3770.7171962102952;3773.6226377362045;3787.5454945406177;10566.41884696349;10767.83848242277;10925.344479331265;10930.56277748881;10938.343699377903;10817;10834.404107773991;10845.403502807421;10850.348979061282;10855.945720271347;7719.729809456642;7997.640106195236;8006.479578827358;8057.153998830156;8218.547979861165;5609.32688077417;5769.07694768835;5770.307563092288;5789.884202316014;5850.473457388855;9344.766380840261;9448.12318200312;9481.051894810464;9539.809203816023;9719.17387022111;9721.854172187564;9764.414135151914;9794.216462682825;9857.260705446977;9900.702978910644;7497.550146991198;7558.962205188939;7559.433042521943;7641.885371719318;7697.114831794192;8124.878126828221;8279.83440331178;8285.295749861329;8292.58537073156;8295.709650162215;7409.740659076906;7430.331270185709;7522.661480233293;7662.923370766221;7887.684492620231;7313.062038559892;7418.814529636802;7430;7460.3658689012045;7526.360259378014;6334.5430550972615;6459.677016149268;6471;6477.060826180272;6481.708323125376;4749.26386410107;4918.655694101379;4939.357443767711;4989.35138432016;4996.375453068366;4911.901761964812;4915.7542122893;5011.649184557046;5032.6225533084435;5035.244713293036 11:06:15 INFO - PROCESS | 5035 | |4;prototype.html;328.23879372243306;338.8356647026193;342.9931401371971;343.7044142037847;346.321210427562;5265.86835329117;5406.729663516828;5426.918596221055;5498.257735205746;5562.276904002484;5234.895302093965;5317.760700768475;5342.5993050521265;5349.7057661828585;5408.4050754416985;4166.937495937564;4223.72545784523;4250.001249706316;4279.459394617935;4281.229378711831;4138.855140070098;4213.47331583552;4246.80889359978;4279.40088387626;4289.978550107245;4200.936985945214;4206.663466922639;4207.85272515462;4221.662267018631;4229.365595160735;4203.579642035787;4208.705390622657;4227.816211460796;4237.4915010198665;4248.617624413818;3708.2398108387715;3769.5288088988877;3791.3554695701796;3806.1816709407613;3817.675497582709;5236.7119808410525;5241.580673546146;5247.344081989751;5248.8687782805355;5249;4831.299461578052;4853.854384368439;4859.684120532154;4884.560389564921;4885.804567817283;5469.808556700496;5550.4449555044175;5586.944130558723;5587.373934250895;5614.214010038598;4101.487314085739;4110.547839737656;4114.362273847559;4121;4153.584641535822;5806.303243610751;5809.506191973687;5811.099279611667;5817.214676018725;5885.881082810185;4141.689373296955;4228.450301460791;4249.3413520904305;4259.21204577148;4264.616184543344;4242.0455397535925;4248.851290204828;4271.658267338606;4276.401303817468;4294.82820687169;4809.110314591811;4823.686460380064;4828.227483602606;4832.710037397767;4841.419029716457;5386.784528618811;5606.775728970795;5615.006672631157;5633.126865335879;5642.984262832648;1425.5580769961346;1448.761309080742;1449.9202543859979;1452.7094581083825;1452.847451017649;881.6076845803556;909.4725059465494;919.1497864475333;926.6247169896203;939.6382392778829;4722.197226471508;4729.351563124661;4736.952630473651;4737.715737055788;4769.95230047702;5006.599472042228;5007.798128449146;5008.348914641147;5023.748812559357;5058.241263810384;4754.334393184957;4783.966814103992;4799.712017278975;4830.227163653799;5017.949820501748;2963.303623648441;3028.273883886208;3032.9839503766484;3036.5596988436555;3052.4658184818013;5893.528517718572;5898.84972430372;5906.2912450505355;5916.792912248051;5928.347881733092;5570.470805273492;5817.301923769175;5847;5861.941380586225;5876.794312199138;5867;5877.294724633071;5889.469947704727;5896.262967129109;5913.319968203626;5568.888622227451;5678.290213723285;5708.600397972102;5720.34110108064;5727.427257274239;5690.601657883908;5719.5138413235345;5748.885022299447;5761.539076873756;5783.789996551954;5934.6735929522565;5981.401859814157;5992.43071908168;6009.819705408845;6012.368701286302;3849.9615003849603;3906.492156019813;4062.532808726916;4115.773632450244;4125.64931980785;5734.369219385948;5745.91381129275;5748.913766293425;5751.865233447865;5769.59612827098;5625.831225063254;5662.745176467151;5662.943370566406;5682.14767784819;5713.685747283939;5411.756470958895;5639.661620302631;5640.830775076754;5654.15187721845;5670.177824215548;5616.714222179907;5639.182318563703;5654.717264136694;5669.3480249770155;5673.943260567342;5469.507744303032;5667.319921609434;5696.401877802937;5704.857378565403;5710.114932185518;5520.917186242129;5528.944710552843;5534.280543529316;5541.251930989265;5592.3848376677715 11:06:15 INFO - PROCESS | 5035 | |5;yui.html;714.7819914925947;816.7715715914159;822.9433842680162;829.067299288301;829.7510746775965;13162.407691653874;13309.068365214438;13431.261280629573;13442;13512.527061552848;11565.710857228574;13965.79051314231;14018.929905350484;14170.220637864913;14228.146311221333;777.3392616276149;783.0837919634042;783.9372850171973;783.9451238413313;783.9764807055798;804.4007214625112;806.681360862459;807.0114110214998;807.0517142357736;807.184743409158;849.0829903704016;849.6006876767909;850.3282406898543;850.8978922529305;850.9829803403928;850.4684572142411;851.748734123435;851.8977722673256;852.4459101583958;852.897652281727;613.5858295650418;614.0298328640737;614.1310046284502;614.241411856357;614.2874265851591;13565.728685426335;13658.931705341509;13660;13682.726345473035;13719.657008574766;13706.725865482735;13994.300284985811;14360.281985900663;14393.928030359886;14428.783568246485;11246.887531124748;11284.830727539094;11298.265612735227;11363.715907102305;11364.602238921598;3740.2706472237924;3755.530558680165;3763.5107436033413;3793.487879136309;3815.8473661053526;62763.372366276664;63236;64444.355556444774;64521.67739161274;64913.3508664912;10983.780324393467;11104.500297486633;11132.332060076422;11291.040261577693;11447.25592836463;20933.476663083544;21281.148754049973;21308.680369794467;21322.36032919015;21336.573268534543;7593.810154746176;7669.769906902802;7904.0910295315625;8026.398020148512;8276.917230827736;4569.360289559464;4573;4673.906521869543;4726.291056341576;4879.048585525859;3337.6829201225846;3435.484677298375;3440.535527703728;3443.896683099511;3444.7588668793446;574.1359254322218;581.0673868441176;585.487698264019;594.2126682146173;595.3480938372476;585.7217821534822;660.1451120798578;684.9006894000441;705.206642527157;721.3760097515611;9232.723018309462;9238.445693258425;9312.603426578293;9383.577739001761;9434.90565094354;706.2972342519124;722.5772922840198;723.3345322303494;727.9344858962613;733.9119305683353;4297.269464191095;4512.2554778461845;4640.86077417678;4661.347411362412;4741.644376671695;86388.56805715931;88917.55541222253;89150;89771.55114224387;90616.54691726631;48846;48956.51043489591;49961.25058124131;50514.242286365734;81129.78305325424;67738.9839152413;68095.65952170208;70502.29497704958;70952.64523677452;71715.6414217936;8720.476771393483;8725;8974.955125224333;9013.324000699842;9059.68291109808;42318.57681423146;44506.3324050146;45719.08561828678;45757.77121114373;49142.50857491522;40694.79652601718;56221.15668264897;56311.15533266922;59120.70439647774;61383.38616613777;12468.625941221779;12489.93755031219;12510.249385036926;12529.436175372313;12588.370581470706;14000.526522320335;14063.789043164565;14092.577222683336;14261.215633139862;14402.567922962327;13256.867431325563;13262.867371326163;13359.1316564423;13652.65868353299;13813.447462101805;12112.469389171394;12302.569410070604;12388.256704597752;12588.87411125877;13026.609201723963;11695.649130526097;12212.938935305267;12322.568710095104;12527.18573292733;13244.072914895865;10540.367577945348;10817.242793004414;10831.404272765074;10889.183311251529;10951;10775.568977240822;11299.43502824872;11345.205835591429;11395.544178232778;11487 11:06:15 INFO - PROCESS | 5035 | __end_tp_report 11:06:15 INFO - PROCESS | 5035 | __start_cc_report 11:06:15 INFO - PROCESS | 5035 | _x_x_mozilla_cycle_collect,1285 11:06:15 INFO - PROCESS | 5035 | __end_cc_report 11:06:15 INFO - PROCESS | 5035 | __startTimestamp1478109975068__endTimestamp 11:06:15 INFO - PROCESS | 5035 | 11:06:15 INFO - PROCESS | 5035 | ------- Summary: start ------- 11:06:15 INFO - PROCESS | 5035 | Number of tests: 6 11:06:15 INFO - PROCESS | 5035 | 11:06:15 INFO - PROCESS | 5035 | [#0] dojo.html Cycles:165 Average:5376.09 Median:5540.39 stddev:599.16 (10.8%) stddev-sans-first:572.35 11:06:15 INFO - PROCESS | 5035 | Values: 3042.3 3084.9 3089.5 3113.2 3139.9 5349.4 5382.0 5433.2 5494.8 5495.6 5429.0 5456.7 5510.7 5524.0 5615.1 4926.9 4960.7 5039.2 5056.5 5068.1 4938.8 4945.2 4986.6 5008.2 5035.6 5024.5 5042.9 5044.6 5084.5 5093.5 4797.5 4840.4 4843.7 5002.5 5066.2 4855.2 4856.8 4863.5 4874.9 4895.1 5356.9 5365.1 5369.6 5384.3 5440.2 5759.0 5760.7 5761.1 5765.6 5770.6 5627.0 5671.5 5800.1 5851.9 5883.0 5487.3 5488.2 5494.4 5494.6 5551.3 5948.5 6016.5 6024.5 6024.6 6025.3 5481.0 5517.6 5595.0 5636.4 5751.2 5698.4 5740.4 5741.7 5780.8 5793.7 5714.4 5716.7 5717.7 5721.7 5723.1 5557.9 5568.7 5616.6 5733.7 5792.0 4453.7 4478.3 4478.9 4493.5 4535.4 3955.6 3956.8 3966.4 4005.0 4018.4 5142.0 5487.8 5490.0 5494.6 5499.4 5584.8 5739.2 5749.9 5787.9 5848.9 5413.5 5425.3 5434.1 5434.8 5439.1 5036.0 5040.4 5042.2 5045.8 5092.9 5771.9 5901.2 5919.9 5978.1 5984.6 5811.2 5815.0 5816.1 5816.7 5865.6 5921.5 5964.7 5968.7 5975.2 5976.2 5540.4 5583.2 5635.5 5639.2 5677.2 5793.2 5794.7 5800.2 5843.8 5866.6 5640.7 5692.9 5694.0 5694.3 5708.1 5495.2 5531.0 5643.0 5662.5 5681.4 5677.1 5704.2 5705.8 5752.0 5772.0 5705.6 5764.9 5767.7 5769.3 5771.2 5354.8 5355.7 5379.1 5432.6 5435.7 11:06:15 INFO - PROCESS | 5035 | 11:06:15 INFO - PROCESS | 5035 | [#1] ext.html Cycles:180 Average:56804.28 Median:39911.00 stddev:107193.98 (268.6%) stddev-sans-first:107411.50 11:06:15 INFO - PROCESS | 5035 | Values: 557.6 576.9 591.2 591.3 606.2 31081.7 43237.0 43970.3 44002.8 44207.3 43520.8 43759.8 43932.3 43941.3 44010.3 8029.7 8753.2 8922.2 8932.0 8933.7 7823.2 10545.4 10804.6 10817.0 11164.2 10809.1 10831.2 10868.5 10869.5 10871.4 8183.2 8431.9 10804.5 10869.5 10878.0 8175.6 8240.4 10284.6 10661.1 10674.7 42157.4 42385.0 42414.2 42516.0 42548.0 3543.8 3579.0 3871.5 4008.7 4048.7 29890.4 31159.4 31477.2 31704.8 32214.4 4272.8 4286.9 4326.7 4383.0 4464.3 331693.0 331934.0 331947.0 333440.0 333659.0 56422.0 56722.4 56758.7 56795.0 56845.4 58609.7 58698.1 58863.4 58906.4 58908.7 16447.5 16585.0 16666.8 16773.0 16776.3 11265.9 11397.5 11889.6 11984.1 12314.5 15837.4 16361.5 16400.8 16414.9 16425.8 6177.5 6475.3 6529.2 6595.3 6603.7 935.3 1023.8 1039.1 1042.7 1050.4 29811.9 29818.6 29867.4 29985.4 30501.0 1067.4 1102.4 1113.1 1178.3 1185.4 15029.8 15833.4 15926.4 16087.5 16257.5 454216.0 456742.0 457891.0 460768.0 461106.0 55175.7 55827.7 55963.7 56026.7 56034.4 1303.9 1314.3 1370.5 1371.7 1373.1 29718.0 30738.8 30820.4 31476.0 31776.0 50665.7 50967.0 51092.2 51125.5 51210.0 416250.0 417216.0 417250.0 418644.0 419584.0 39848.2 40629.6 41346.4 41495.8 41497.4 36983.3 42734.8 45520.5 45671.5 45963.0 38699.6 39772.5 39981.2 40026.6 41234.8 39292.6 39312.0 39662.8 40621.8 41114.8 39452.6 39973.8 40359.2 40395.6 40408.2 33428.3 34922.0 35446.5 36071.3 36112.1 25812.2 26438.3 26485.2 26485.9 26553.3 11:06:15 INFO - PROCESS | 5035 | 11:06:15 INFO - PROCESS | 5035 | [#2] jquery.html Cycles:180 Average:26564.21 Median:2274.70 stddev:74303.17 (3266.5%) stddev-sans-first:74485.62 11:06:15 INFO - PROCESS | 5035 | Values: 392.5 393.7 401.7 404.4 419.5 13947.0 17188.2 17911.8 19376.5 19389.2 15345.0 17124.9 18238.8 18288.5 18768.0 5480.1 5665.7 5666.6 5677.8 5692.6 5505.4 5522.8 5606.7 5616.0 5616.9 5680.7 5826.3 5832.4 5838.5 5841.9 5518.4 5573.0 5575.7 5640.0 5695.4 5446.5 5448.7 5451.1 5453.7 5458.5 13444.1 13539.0 13575.7 13624.8 19952.7 2192.8 2256.3 2293.1 2353.9 2537.4 9693.4 10014.8 10169.1 10193.4 10223.4 1842.3 1959.8 1979.2 2023.9 2121.0 75820.0 76830.6 79639.6 81392.6 82792.0 9854.0 10073.7 10113.9 10235.7 10449.7 14008.3 14120.8 14199.3 14202.9 14221.2 7126.3 7452.1 7588.2 7684.2 8039.8 7801.5 7812.4 8044.2 8159.0 8204.3 4343.1 4444.9 4501.8 4578.5 4593.0 1742.3 1772.2 1779.8 1821.0 1846.9 837.9 927.4 928.5 1022.8 1039.8 16984.3 17953.3 18028.1 18205.5 18374.8 925.7 962.7 980.6 994.3 1000.3 9529.8 10130.8 10173.5 10241.0 10369.6 146718.0 488941.0 489749.0 489840.0 506369.0 79672.0 101925.5 103048.0 104270.5 104273.0 1008.4 1050.5 1052.8 1059.5 1063.4 16554.2 16670.6 17193.5 17279.4 17318.6 39021.8 39977.8 40592.4 41159.8 41584.6 41909.6 49398.0 55153.0 58359.4 61054.4 7792.8 8212.4 8382.2 8421.4 8909.1 10024.5 12402.4 12526.5 12543.9 12650.8 11221.6 11278.5 11312.2 11575.5 11672.1 10538.3 10615.6 10702.5 11180.6 11361.1 11218.9 11347.8 11350.4 11367.4 12037.1 8112.8 8212.6 8264.6 8501.8 8715.5 9911.5 10947.9 11204.7 11332.9 11628.7 11:06:15 INFO - PROCESS | 5035 | 11:06:15 INFO - PROCESS | 5035 | [#3] mootools.html Cycles:180 Average:5661.36 Median:4964.76 stddev:3185.35 (64.2%) stddev-sans-first:3178.62 11:06:15 INFO - PROCESS | 5035 | Values: 1458.2 1491.3 1589.9 1734.5 1746.8 7423.6 7693.2 8150.9 8661.4 8705.5 8212.2 8439.7 8455.7 8670.0 8682.8 2314.8 2348.1 2348.3 2349.1 2349.2 2055.3 2108.9 2345.1 2358.3 2429.4 2293.0 2373.9 2377.6 2381.4 2382.2 2334.9 2354.8 2358.7 2366.1 2388.1 2369.8 2380.4 2393.7 2396.1 2415.0 8667.4 8726.3 8733.4 8769.8 8774.5 5176.3 5332.8 5334.7 5336.1 5348.4 3329.5 3465.8 3602.5 3605.9 3726.9 1078.9 1092.5 1110.9 1113.5 1138.6 12010.6 12018.8 12033.6 12052.2 12060.7 4394.0 4634.4 4722.6 4771.4 4780.7 9984.1 9993.8 10091.9 10094.7 10095.8 5345.0 5345.4 5347.2 5348.6 5352.3 4716.2 4768.9 4836.6 4933.3 4940.2 3853.4 3870.1 3909.7 3957.9 3984.2 1169.1 1196.5 1240.6 1251.2 1280.7 797.4 897.2 900.2 914.9 920.2 5377.4 5452.6 5467.8 5601.2 5618.9 970.1 986.3 1005.1 1038.5 1070.2 3714.6 3731.6 3770.7 3773.6 3787.5 10566.4 10767.8 10925.3 10930.6 10938.3 10817.0 10834.4 10845.4 10850.3 10855.9 7719.7 7997.6 8006.5 8057.2 8218.5 5609.3 5769.1 5770.3 5789.9 5850.5 9344.8 9448.1 9481.1 9539.8 9719.2 9721.9 9764.4 9794.2 9857.3 9900.7 7497.6 7559.0 7559.4 7641.9 7697.1 8124.9 8279.8 8285.3 8292.6 8295.7 7409.7 7430.3 7522.7 7662.9 7887.7 7313.1 7418.8 7430.0 7460.4 7526.4 6334.5 6459.7 6471.0 6477.1 6481.7 4749.3 4918.7 4939.4 4989.4 4996.4 4911.9 4915.8 5011.6 5032.6 5035.2 11:06:15 INFO - PROCESS | 5035 | 11:06:15 INFO - PROCESS | 5035 | [#4] prototype.html Cycles:180 Average:4699.14 Median:5257.43 stddev:1369.21 (26.0%) stddev-sans-first:1333.17 11:06:15 INFO - PROCESS | 5035 | Values: 328.2 338.8 343.0 343.7 346.3 5265.9 5406.7 5426.9 5498.3 5562.3 5234.9 5317.8 5342.6 5349.7 5408.4 4166.9 4223.7 4250.0 4279.5 4281.2 4138.9 4213.5 4246.8 4279.4 4290.0 4200.9 4206.7 4207.9 4221.7 4229.4 4203.6 4208.7 4227.8 4237.5 4248.6 3708.2 3769.5 3791.4 3806.2 3817.7 5236.7 5241.6 5247.3 5248.9 5249.0 4831.3 4853.9 4859.7 4884.6 4885.8 5469.8 5550.4 5586.9 5587.4 5614.2 4101.5 4110.5 4114.4 4121.0 4153.6 5806.3 5809.5 5811.1 5817.2 5885.9 4141.7 4228.5 4249.3 4259.2 4264.6 4242.0 4248.9 4271.7 4276.4 4294.8 4809.1 4823.7 4828.2 4832.7 4841.4 5386.8 5606.8 5615.0 5633.1 5643.0 1425.6 1448.8 1449.9 1452.7 1452.8 881.6 909.5 919.1 926.6 939.6 4722.2 4729.4 4737.0 4737.7 4770.0 5006.6 5007.8 5008.3 5023.7 5058.2 4754.3 4784.0 4799.7 4830.2 5017.9 2963.3 3028.3 3033.0 3036.6 3052.5 5893.5 5898.8 5906.3 5916.8 5928.3 5570.5 5817.3 5847.0 5861.9 5876.8 5867.0 5877.3 5889.5 5896.3 5913.3 5568.9 5678.3 5708.6 5720.3 5727.4 5690.6 5719.5 5748.9 5761.5 5783.8 5934.7 5981.4 5992.4 6009.8 6012.4 3850.0 3906.5 4062.5 4115.8 4125.6 5734.4 5745.9 5748.9 5751.9 5769.6 5625.8 5662.7 5662.9 5682.1 5713.7 5411.8 5639.7 5640.8 5654.2 5670.2 5616.7 5639.2 5654.7 5669.3 5673.9 5469.5 5667.3 5696.4 5704.9 5710.1 5520.9 5528.9 5534.3 5541.3 5592.4 11:06:15 INFO - PROCESS | 5035 | 11:06:15 INFO - PROCESS | 5035 | [#5] yui.html Cycles:180 Average:17048.59 Median:4667.63 stddev:22222.93 (476.1%) stddev-sans-first:22251.43 11:06:15 INFO - PROCESS | 5035 | Values: 714.8 816.8 822.9 829.1 829.8 13162.4 13309.1 13431.3 13442.0 13512.5 11565.7 13965.8 14018.9 14170.2 14228.1 777.3 783.1 783.9 783.9 784.0 804.4 806.7 807.0 807.1 807.2 849.1 849.6 850.3 850.9 851.0 850.5 851.7 851.9 852.4 852.9 613.6 614.0 614.1 614.2 614.3 13565.7 13658.9 13660.0 13682.7 13719.7 13706.7 13994.3 14360.3 14393.9 14428.8 11246.9 11284.8 11298.3 11363.7 11364.6 3740.3 3755.5 3763.5 3793.5 3815.8 62763.4 63236.0 64444.4 64521.7 64913.4 10983.8 11104.5 11132.3 11291.0 11447.3 20933.5 21281.1 21308.7 21322.4 21336.6 7593.8 7669.8 7904.1 8026.4 8276.9 4569.4 4573.0 4673.9 4726.3 4879.0 3337.7 3435.5 3440.5 3443.9 3444.8 574.1 581.1 585.5 594.2 595.3 585.7 660.1 684.9 705.2 721.4 9232.7 9238.4 9312.6 9383.6 9434.9 706.3 722.6 723.3 727.9 733.9 4297.3 4512.3 4640.9 4661.3 4741.6 86388.6 88917.6 89150.0 89771.6 90616.5 48846.0 48956.5 49961.3 50514.2 81129.8 67739.0 68095.7 70502.3 70952.6 71715.6 8720.5 8725.0 8975.0 9013.3 9059.7 42318.6 44506.3 45719.1 45757.8 49142.5 40694.8 56221.2 56311.2 59120.7 61383.4 12468.6 12489.9 12510.2 12529.4 12588.4 14000.5 14063.8 14092.6 14261.2 14402.6 13256.9 13262.9 13359.1 13652.7 13813.4 12112.5 12302.6 12388.3 12588.9 13026.6 11695.6 12212.9 12322.6 12527.2 13244.1 10540.4 10817.2 10831.4 10889.2 10951.0 10775.6 11299.4 11345.2 11395.5 11487.0 11:06:15 INFO - PROCESS | 5035 | -------- Summary: end -------- 11:06:15 INFO - PROCESS | 5035 | 11:06:15 INFO - TEST-INFO | 5035: exit 0 11:06:16 INFO - TEST-OK | dromaeo_css | took 1116545ms 11:06:16 INFO - TEST-START | kraken 11:06:16 INFO - operating with platform_type : linux_ 11:06:16 INFO - Initialising browser for kraken test... 11:06:16 INFO - TEST-INFO | started process 5340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLtv7nh/profile http://localhost:38825/getInfo.html) 11:06:19 INFO - PROCESS | 5340 | __metrics Screen width/height:1600/1200 11:06:19 INFO - PROCESS | 5340 | colorDepth:24 11:06:19 INFO - PROCESS | 5340 | Browser inner width/height: 1024/697 11:06:19 INFO - PROCESS | 5340 | __metrics 11:06:20 INFO - PROCESS | 5340 | 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" 11:06:20 INFO - PROCESS | 5340 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:06:20 INFO - PROCESS | 5340 | console.error: PushService: 11:06:20 INFO - PROCESS | 5340 | stateChangeProcessEnqueue: Error transitioning state 11:06:20 INFO - PROCESS | 5340 | UnknownError 11:06:21 INFO - TEST-INFO | 5340: exit 0 11:06:21 INFO - Browser initialized. 11:06:21 INFO - Running cycle 1/1 for kraken test... 11:06:21 INFO - TEST-INFO | started process 5423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLtv7nh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:06:33 INFO - PROCESS | 5423 | RSS: Main: 172965888 11:06:33 INFO - PROCESS | 5423 | 11:06:36 INFO - PROCESS | 5423 | Cycle 1(1): loaded http://localhost:38825/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38825/tests/kraken/driver.html?testName=audio-beat-detection) 11:06:37 INFO - PROCESS | 5423 | RSS: Main: 228872192 11:06:37 INFO - PROCESS | 5423 | 11:06:39 INFO - PROCESS | 5423 | Cycle 1(1): loaded http://localhost:38825/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38825/tests/kraken/driver.html?testName=audio-dft) 11:06:40 INFO - PROCESS | 5423 | RSS: Main: 216092672 11:06:40 INFO - PROCESS | 5423 | 11:06:43 INFO - PROCESS | 5423 | Cycle 1(1): loaded http://localhost:38825/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38825/tests/kraken/driver.html?testName=audio-fft) 11:06:44 INFO - PROCESS | 5423 | RSS: Main: 297938944 11:06:44 INFO - PROCESS | 5423 | 11:06:46 INFO - PROCESS | 5423 | Cycle 1(1): loaded http://localhost:38825/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38825/tests/kraken/driver.html?testName=audio-oscillator) 11:06:46 INFO - PROCESS | 5423 | RSS: Main: 209051648 11:06:46 INFO - PROCESS | 5423 | 11:06:48 INFO - PROCESS | 5423 | Cycle 1(1): loaded http://localhost:38825/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38825/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:06:49 INFO - PROCESS | 5423 | RSS: Main: 212426752 11:06:49 INFO - PROCESS | 5423 | 11:06:52 INFO - PROCESS | 5423 | Cycle 1(1): loaded http://localhost:38825/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38825/tests/kraken/driver.html?testName=imaging-darkroom) 11:06:53 INFO - PROCESS | 5423 | RSS: Main: 248094720 11:06:53 INFO - PROCESS | 5423 | 11:06:56 INFO - PROCESS | 5423 | Cycle 1(1): loaded http://localhost:38825/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38825/tests/kraken/driver.html?testName=imaging-desaturate) 11:06:56 INFO - PROCESS | 5423 | RSS: Main: 247558144 11:06:56 INFO - PROCESS | 5423 | 11:06:59 INFO - PROCESS | 5423 | Cycle 1(1): loaded http://localhost:38825/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38825/tests/kraken/driver.html?testName=json-parse-financial) 11:07:00 INFO - PROCESS | 5423 | RSS: Main: 246558720 11:07:00 INFO - PROCESS | 5423 | 11:07:01 INFO - PROCESS | 5423 | Cycle 1(1): loaded http://localhost:38825/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38825/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:07:02 INFO - PROCESS | 5423 | RSS: Main: 209100800 11:07:02 INFO - PROCESS | 5423 | 11:07:03 INFO - PROCESS | 5423 | Cycle 1(1): loaded http://localhost:38825/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38825/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:07:04 INFO - PROCESS | 5423 | RSS: Main: 216645632 11:07:04 INFO - PROCESS | 5423 | 11:07:06 INFO - PROCESS | 5423 | Cycle 1(1): loaded http://localhost:38825/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38825/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:07:07 INFO - PROCESS | 5423 | RSS: Main: 226230272 11:07:07 INFO - PROCESS | 5423 | 11:07:09 INFO - PROCESS | 5423 | Cycle 1(1): loaded http://localhost:38825/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38825/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:07:10 INFO - PROCESS | 5423 | RSS: Main: 233021440 11:07:10 INFO - PROCESS | 5423 | 11:07:13 INFO - PROCESS | 5423 | Cycle 1(1): loaded http://localhost:38825/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38825/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:07:13 INFO - PROCESS | 5423 | RSS: Main: 230563840 11:07:13 INFO - PROCESS | 5423 | 11:07:15 INFO - PROCESS | 5423 | Cycle 1(1): loaded http://localhost:38825/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38825/tests/kraken/driver.html?testName=ai-astar) 11:07:15 INFO - PROCESS | 5423 | RSS: Main: 282013696 11:07:15 INFO - PROCESS | 5423 | 11:07:15 INFO - PROCESS | 5423 | __start_tp_report 11:07:15 INFO - PROCESS | 5423 | _x_x_mozilla_page_load 11:07:15 INFO - PROCESS | 5423 | _x_x_mozilla_page_load_details 11:07:15 INFO - PROCESS | 5423 | |i|pagename|runs| 11:07:15 INFO - PROCESS | 5423 | |0;ai-astar;105;114;114;113;113;113;114;111;112;112 11:07:15 INFO - PROCESS | 5423 | |1;audio-beat-detection;151;121;122;170;129;123;124;124;155;124 11:07:15 INFO - PROCESS | 5423 | |2;audio-dft;160;162;161;161;162;162;161;161;164;162 11:07:15 INFO - PROCESS | 5423 | |3;audio-fft;75;76;76;107;75;75;75;76;97;75 11:07:15 INFO - PROCESS | 5423 | |4;audio-oscillator;82;82;117;83;82;82;102;82;82;117 11:07:15 INFO - PROCESS | 5423 | |5;imaging-gaussian-blur;116;117;116;116;116;116;116;116;116;117 11:07:15 INFO - PROCESS | 5423 | |6;imaging-darkroom;147;145;146;146;146;146;146;145;145;146 11:07:15 INFO - PROCESS | 5423 | |7;imaging-desaturate;85;85;85;86;85;86;86;85;86;85 11:07:15 INFO - PROCESS | 5423 | |8;json-parse-financial;53;52;52;51;51;54;55;53;53;52 11:07:15 INFO - PROCESS | 5423 | |9;json-stringify-tinderbox;59;60;60;60;60;60;60;60;60;60 11:07:15 INFO - PROCESS | 5423 | |10;stanford-crypto-aes;88;85;79;82;83;80;80;79;88;81 11:07:15 INFO - PROCESS | 5423 | |11;stanford-crypto-ccm;132;129;133;128;129;130;128;136;180;129 11:07:15 INFO - PROCESS | 5423 | |12;stanford-crypto-pbkdf2;172;168;174;164;167;168;166;165;168;165 11:07:15 INFO - PROCESS | 5423 | |13;stanford-crypto-sha256-iterative;64;64;64;64;64;65;67;66;63;63 11:07:15 INFO - PROCESS | 5423 | __end_tp_report 11:07:15 INFO - PROCESS | 5423 | __start_cc_report 11:07:15 INFO - PROCESS | 5423 | _x_x_mozilla_cycle_collect,1678 11:07:15 INFO - PROCESS | 5423 | __end_cc_report 11:07:15 INFO - PROCESS | 5423 | __startTimestamp1478110035845__endTimestamp 11:07:15 INFO - PROCESS | 5423 | 11:07:15 INFO - PROCESS | 5423 | ------- Summary: start ------- 11:07:15 INFO - PROCESS | 5423 | Number of tests: 14 11:07:15 INFO - PROCESS | 5423 | 11:07:15 INFO - PROCESS | 5423 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:2.69 (2.4%) stddev-sans-first:1.05 11:07:15 INFO - PROCESS | 5423 | Values: 105.0 114.0 114.0 113.0 113.0 113.0 114.0 111.0 112.0 112.0 11:07:15 INFO - PROCESS | 5423 | 11:07:15 INFO - PROCESS | 5423 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:126.50 stddev:17.59 (13.9%) stddev-sans-first:17.59 11:07:15 INFO - PROCESS | 5423 | Values: 151.0 121.0 122.0 170.0 129.0 123.0 124.0 124.0 155.0 124.0 11:07:15 INFO - PROCESS | 5423 | 11:07:15 INFO - PROCESS | 5423 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:0.97 11:07:15 INFO - PROCESS | 5423 | Values: 160.0 162.0 161.0 161.0 162.0 162.0 161.0 161.0 164.0 162.0 11:07:15 INFO - PROCESS | 5423 | 11:07:15 INFO - PROCESS | 5423 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.50 stddev:11.48 (15.2%) stddev-sans-first:11.99 11:07:15 INFO - PROCESS | 5423 | Values: 75.0 76.0 76.0 107.0 75.0 75.0 75.0 76.0 97.0 75.0 11:07:15 INFO - PROCESS | 5423 | 11:07:15 INFO - PROCESS | 5423 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:82.00 stddev:14.99 (18.3%) stddev-sans-first:15.54 11:07:15 INFO - PROCESS | 5423 | Values: 82.0 82.0 117.0 83.0 82.0 82.0 102.0 82.0 82.0 117.0 11:07:15 INFO - PROCESS | 5423 | 11:07:15 INFO - PROCESS | 5423 | [#5] imaging-gaussian-blur Cycles:10 Average:116.20 Median:116.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:07:15 INFO - PROCESS | 5423 | Values: 116.0 117.0 116.0 116.0 116.0 116.0 116.0 116.0 116.0 117.0 11:07:15 INFO - PROCESS | 5423 | 11:07:15 INFO - PROCESS | 5423 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 11:07:15 INFO - PROCESS | 5423 | Values: 147.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 11:07:15 INFO - PROCESS | 5423 | 11:07:15 INFO - PROCESS | 5423 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 11:07:15 INFO - PROCESS | 5423 | Values: 85.0 85.0 85.0 86.0 85.0 86.0 86.0 85.0 86.0 85.0 11:07:15 INFO - PROCESS | 5423 | 11:07:15 INFO - PROCESS | 5423 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:1.26 (2.4%) stddev-sans-first:1.33 11:07:15 INFO - PROCESS | 5423 | Values: 53.0 52.0 52.0 51.0 51.0 54.0 55.0 53.0 53.0 52.0 11:07:15 INFO - PROCESS | 5423 | 11:07:15 INFO - PROCESS | 5423 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.32 (0.5%) stddev-sans-first:0.00 11:07:15 INFO - PROCESS | 5423 | Values: 59.0 60.0 60.0 60.0 60.0 60.0 60.0 60.0 60.0 60.0 11:07:15 INFO - PROCESS | 5423 | 11:07:15 INFO - PROCESS | 5423 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.50 stddev:3.44 (4.2%) stddev-sans-first:3.02 11:07:15 INFO - PROCESS | 5423 | Values: 88.0 85.0 79.0 82.0 83.0 80.0 80.0 79.0 88.0 81.0 11:07:15 INFO - PROCESS | 5423 | 11:07:15 INFO - PROCESS | 5423 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:131.00 stddev:15.88 (12.1%) stddev-sans-first:16.79 11:07:15 INFO - PROCESS | 5423 | Values: 132.0 129.0 133.0 128.0 129.0 130.0 128.0 136.0 180.0 129.0 11:07:15 INFO - PROCESS | 5423 | 11:07:15 INFO - PROCESS | 5423 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:168.00 stddev:3.16 (1.9%) stddev-sans-first:2.95 11:07:15 INFO - PROCESS | 5423 | Values: 172.0 168.0 174.0 164.0 167.0 168.0 166.0 165.0 168.0 165.0 11:07:15 INFO - PROCESS | 5423 | 11:07:15 INFO - PROCESS | 5423 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.00 stddev:1.26 (2.0%) stddev-sans-first:1.33 11:07:15 INFO - PROCESS | 5423 | Values: 64.0 64.0 64.0 64.0 64.0 65.0 67.0 66.0 63.0 63.0 11:07:15 INFO - PROCESS | 5423 | -------- Summary: end -------- 11:07:15 INFO - PROCESS | 5423 | 11:07:16 INFO - TEST-INFO | 5423: exit 0 11:07:16 INFO - TEST-OK | kraken | took 60969ms 11:07:16 INFO - SUITE-END | took 1177s 11:07:17 INFO - Completed test suite (00:19:37) 11:07:17 INFO - javascript benchmark 11:07:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3042.345895632439, 3084.9228769280767, 3089.459344614693, 3113.2372568720666, 3139.9215019624507, 5349.411564727887, 5381.973090134544, 5433.239346491489, 5494.752736126874, 5495.560355171581, 5429.0, 5456.727163641822, 5510.669359838413, 5524.033294173523, 5615.129654903497, 4926.876828079291, 4960.702357858522, 5039.168537191359, 5056.469070747574, 5068.087744206042, 4938.7530623468865, 4945.159322915113, 4986.626003049768, 5008.198688209887, 5035.62232832539, 5024.497550244964, 5042.924356134661, 5044.596432285409, 5084.4661310562415, 5093.541581257686, 4797.544233297866, 4840.370751802278, 4843.685160464559, 5002.52476014778, 5066.16408292635, 4855.247436647325, 4856.781444834991, 4863.489333619955, 4874.8537543873745, 4895.0944075345815, 5356.892862142774, 5365.114756065244, 5369.597280203961, 5384.273123128367, 5440.183972404171, 5758.971205143989, 5760.654360738369, 5761.107028410603, 5765.596408251424, 5770.6249093808765, 5627.043402621564, 5671.546276297928, 5800.129980502916, 5851.882962340772, 5883.0, 5487.341519017744, 5488.204210389511, 5494.395616482184, 5494.642848214853, 5551.333839939192, 5948.524118070544, 6016.488598469092, 6024.457798798129, 6024.638521688713, 6025.276966763929, 5481.040817856939, 5517.61376703635, 5594.9929012777275, 5636.379998200195, 5751.223584815996, 5698.373178950312, 5740.425957404226, 5741.655500669973, 5780.797672081457, 5793.710314484259, 5714.399988001283, 5716.742746576414, 5717.656940583495, 5721.656700597978, 5723.055695810144, 5557.861053473695, 5568.6658800472105, 5616.606837521416, 5733.713314334266, 5791.971040144772, 4453.688241823042, 4478.2610869206865, 4478.865634030984, 4493.5281795411665, 4535.387722657399, 3955.6044395560216, 3956.7823769692945, 3966.4050392440786, 4005.0, 4018.3972404139613, 5142.0, 5487.807926722546, 5489.972550137224, 5494.642848214853, 5499.367572729107, 5584.832455026356, 5739.167820666064, 5749.88500229993, 5787.913181302284, 5848.912266316009, 5413.485718856702, 5425.321834770653, 5434.130539113723, 5434.809781657623, 5439.075357189287, 5036.0, 5040.445550989388, 5042.168042272984, 5045.772940217699, 5092.898142037213, 5771.85570360736, 5901.232839730807, 5919.852003699942, 5978.133170690313, 5984.551158663205, 5811.186433899173, 5815.0405183146, 5816.069428891357, 5816.70916454184, 5865.618734782225, 5921.519620094976, 5964.671943043, 5968.701564921824, 5975.16347711312, 5976.163337132892, 5540.390557038642, 5583.190437386637, 5635.549156067586, 5639.210510528611, 5677.205191273308, 5793.217915581343, 5794.710264486843, 5800.216970709069, 5843.766249349978, 5866.6186697864505, 5640.746166422438, 5692.8576785579035, 5693.971530142323, 5694.288213973254, 5708.143778433268, 5495.230667706444, 5531.03206938776, 5642.971785141212, 5662.546996240373, 5681.375048744718, 5677.120046392815, 5704.172894930129, 5705.828825135252, 5751.971240143773, 5772.0, 5705.62913410627, 5764.942350576441, 5767.653940763567, 5769.278840144982, 5771.163181338767, 5354.812581559782, 5355.732213389237, 5379.1393377059485, 5432.565394768488, 5435.701036443033], "value": 5335.967093798507, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.6007460855053, 576.8730879206573, 591.21663795471, 591.3317950715691, 606.166521033579, 31081.689183108192, 43237.0, 43970.340444893314, 44002.779986100024, 44207.33688994667, 43520.782396087976, 43759.78120109403, 43932.341014884805, 43941.340879886826, 44010.33984490227, 8029.718959836407, 8753.212210901018, 8922.197002269795, 8931.95534022329, 8933.731988040368, 7823.178566250519, 10545.367277963309, 10804.621838235664, 10817.0, 11164.218504704673, 10809.081228095582, 10831.187660925423, 10868.510917008714, 10869.510872010738, 10871.402072885989, 8183.222593853575, 8431.873521897176, 10804.513796879159, 10869.510872010778, 10878.0, 8175.63209655567, 8240.423170378075, 10284.588616455407, 10661.147108231324, 10674.73313167177, 42157.367639485434, 42385.0, 42414.1517169658, 42516.0, 42548.0, 3543.8050907200095, 3578.964210357889, 3871.5354157500997, 4008.6793056555407, 4048.7124774502313, 29890.40219195604, 31159.376812463623, 31477.213069673213, 31704.841475792706, 32214.355712885612, 4272.807723652443, 4286.87139385819, 4326.6754993375625, 4383.035732138925, 4464.263396539567, 331693.0, 331934.0, 331947.0, 333440.0, 333659.0, 56422.0, 56722.43277567172, 56758.71620641871, 56795.0, 56845.43154568401, 58609.70695146582, 58698.140843944006, 58863.41136588665, 58906.41093589095, 58908.705456472446, 16447.506574802774, 16585.0, 16666.83333166677, 16773.0, 16776.328946842234, 11265.943670281596, 11397.487113079931, 11889.583864564698, 11984.101192410604, 12314.50741970329, 15837.366505339887, 16361.509154725378, 16400.83599163993, 16414.917925410537, 16425.753613695804, 6177.4749146322165, 6475.32009139043, 6529.15121034272, 6595.340465953463, 6603.669816509156, 935.2845073518764, 1023.8003589300015, 1039.1219419590434, 1042.7341028037802, 1050.4275170032352, 29811.850940745157, 29818.55272170919, 29867.40265194684, 29985.40029199404, 30501.0, 1067.3595842494442, 1102.366139469808, 1113.1373185781085, 1178.2753606531921, 1185.4428418643224, 15029.849701503064, 15833.366665333488, 15926.442574509836, 16087.517374478784, 16257.451954178738, 454216.0, 456742.0, 457891.0, 460768.0, 461106.0, 55175.724121379135, 55827.720861395435, 55963.720181398836, 56026.71986640041, 56034.35776674503, 1303.9348032598332, 1314.3231235913513, 1370.465518447806, 1371.7119404924879, 1373.0663149058537, 29718.0, 30738.754023103396, 30820.383592328475, 31476.0, 31776.0, 50665.74667126641, 50966.999999998516, 51092.23361649504, 51125.488745112074, 51210.0, 416250.0, 417216.0, 417250.0, 418644.0, 419584.0, 39848.203035939696, 40629.59370406258, 41346.379804303564, 41495.792521037205, 41497.37753933754, 36983.26033479369, 42734.78632606817, 45520.54479455295, 45671.54328456673, 45963.0, 38699.6130038696, 39772.534543821785, 39981.2003759929, 40026.59973400229, 41234.79382603068, 39292.60707392889, 39312.0, 39662.801685991384, 40621.79689101536, 41114.79442602887, 39452.605473944895, 39973.80013099916, 40359.192816142924, 40395.59604404036, 40408.19183616252, 33428.33143337071, 34922.0, 35446.46830297496, 36071.27857442784, 36112.09719757027, 25812.22563323103, 26438.339041524116, 26485.205443836716, 26485.85550008739, 26553.336166595218], "value": 19960.50825379679, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.458407397791, 393.6693177730706, 401.67865707434055, 404.38937204820724, 419.5112693711826, 13946.999999999975, 17188.226529806157, 17911.820881791176, 19376.515587110312, 19389.224431022776, 15345.0, 17124.914375428107, 18238.84053937185, 18288.451346459628, 18768.0, 5480.068388373976, 5665.745041473123, 5666.603337766358, 5677.829665110054, 5692.57305702072, 5505.421930697279, 5522.751476183561, 5606.691631960241, 5616.0, 5616.887662246752, 5680.687562184078, 5826.300843898738, 5832.445917637839, 5838.5329173666005, 5841.912371314434, 5518.420565840609, 5572.9968605650965, 5575.749091290882, 5640.04119299718, 5695.430456954313, 5446.455354464561, 5448.673079615236, 5451.100568406208, 5453.727313634303, 5458.5087342139, 13444.126131801402, 13539.0, 13575.660608484768, 13624.795628065587, 19952.70307430027, 2192.8355373346903, 2256.345659758668, 2293.0598454633687, 2353.882305884699, 2537.4328494685055, 9693.369930954465, 10014.799704005953, 10169.084782369622, 10193.439360835151, 10223.437710925897, 1842.2958763144172, 1959.823615874578, 1979.158857485563, 2023.8886861222627, 2120.9575808483896, 75820.0, 76830.61584692041, 79639.60180199062, 81392.59303703443, 82792.0, 9854.0, 10073.748156296151, 10113.94943025295, 10235.692929212135, 10449.738756531147, 14008.299585020708, 14120.788188177186, 14199.29003549839, 14202.857971420153, 14221.217833019284, 7126.251743566954, 7452.105747310249, 7588.203238659971, 7684.231576842383, 8039.839203215903, 7801.517711634771, 7812.3750099993, 8044.195580442026, 8159.0, 8204.302634276153, 4343.087951530151, 4444.866654000385, 4501.842435514807, 4578.473475550288, 4593.0, 1742.2943707798363, 1772.1582248431891, 1779.7953235377838, 1821.0013512907155, 1846.8891866488054, 837.9078301386843, 927.3832901120679, 928.5125309212717, 1022.7801022780138, 1039.823230050878, 16984.32062717502, 17953.281868725106, 18028.098595070456, 18205.505777822094, 18374.81625183731, 925.7361651929168, 962.7400601837464, 980.6371642492323, 994.264244459095, 1000.3347773730533, 9529.761755956157, 10130.797384052277, 10173.54219060144, 10241.0, 10369.585216591251, 146718.0, 488941.0, 489749.0, 489840.0, 506369.0, 79672.0, 101925.49037254915, 103048.0, 104270.47864760627, 104273.0, 1008.4403156248353, 1050.5430137890041, 1052.8157572424948, 1059.5073290919606, 1063.409807556798, 16554.17229138514, 16670.583235418726, 17193.484195474157, 17279.3952211672, 17318.5670358237, 39021.80489097536, 39977.80011099926, 40592.39111413272, 41159.7942010288, 41584.58415415928, 41909.58090419057, 49398.0, 55153.0, 58359.416405837095, 61054.38945610487, 7792.766217013499, 8212.425130240827, 8382.245597896219, 8421.368397370099, 8909.064548222603, 10024.548895299875, 12402.441890114786, 12526.49894004266, 12543.87456125427, 12650.810237846255, 11221.55113795439, 11278.548858045915, 11312.20814542974, 11575.536978521102, 11672.066234701373, 10538.262321637412, 10615.628453004108, 10702.518386672462, 11180.608678696206, 11361.091112711129, 11218.887811121784, 11347.773044539228, 11350.375729334966, 11367.374794386387, 12037.097217708882, 8112.797180070545, 8212.589370531568, 8264.628091736007, 8501.829963400822, 8715.52064636451, 9911.504424778876, 10947.890521095005, 11204.719882003015, 11332.886671133183, 11628.6511404658], "value": 8783.43363793717, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1458.2052781234222, 1491.2692780537536, 1589.9364025438983, 1734.523006173303, 1746.799118101418, 7423.5545867247865, 7693.192214817447, 8150.877736833945, 8661.393702440824, 8705.477671339717, 8212.219839115274, 8439.662413503453, 8455.661773529067, 8670.046294907572, 8682.826343473143, 2314.780095890888, 2348.095983046522, 2348.295511346598, 2349.0721165139844, 2349.2247558305717, 2055.2601063617085, 2108.8523803333696, 2345.061975209921, 2358.3278765551822, 2429.356220601533, 2292.9541409171807, 2373.857568545884, 2377.5958087125146, 2381.4403615150427, 2382.2257766225957, 2334.9066037358484, 2354.799842013431, 2358.705161854768, 2366.1363602285214, 2388.068653225235, 2369.8104151668, 2380.3811009137576, 2393.6648869158157, 2396.077510158584, 2414.9758502414925, 8667.436616619963, 8726.345524085718, 8733.388662793606, 8769.824603507894, 8774.473531588124, 5176.327077479904, 5332.840014799563, 5334.733263336856, 5336.146216605363, 5348.358197016383, 3329.4839299908313, 3465.792052476834, 3602.4596310553366, 3605.855765769366, 3726.8695595654294, 1078.8543546621183, 1092.5192915117402, 1110.9444527773578, 1113.4899453519902, 1138.601489478684, 12010.579629712918, 12018.759624807542, 12033.57882474118, 12052.216605920587, 12060.698482537919, 4394.0, 4634.397528321364, 4722.598579120745, 4771.403574553181, 4780.689255198401, 9984.051515106054, 9993.750156246007, 10091.899081009096, 10094.747631309128, 10095.798084038279, 5344.973275133677, 5345.3852806926925, 5347.171188465794, 5348.572114230852, 5352.304200453994, 4716.245400735866, 4768.880777980509, 4836.637252206098, 4933.28467372229, 4940.1601727706375, 3853.4412510185866, 3870.1098747288283, 3909.7458665186673, 3957.940630890539, 3984.183242435294, 1169.0705888818409, 1196.4675719305, 1240.584404224595, 1251.1992324912064, 1280.7246442015012, 797.4099166616662, 897.1970086772302, 900.2392977933636, 914.92680585553, 920.1626519867023, 5377.4084850666395, 5452.59105567084, 5467.808626698126, 5601.159826026129, 5618.91571626426, 970.1123472023161, 986.2849434160177, 1005.1154983614373, 1038.4765020999046, 1070.208046045936, 3714.6285371462636, 3731.589525152231, 3770.7171962102952, 3773.6226377362045, 3787.5454945406177, 10566.41884696349, 10767.83848242277, 10925.344479331265, 10930.56277748881, 10938.343699377903, 10817.0, 10834.404107773991, 10845.403502807421, 10850.348979061282, 10855.945720271347, 7719.729809456642, 7997.640106195236, 8006.479578827358, 8057.153998830156, 8218.547979861165, 5609.32688077417, 5769.07694768835, 5770.307563092288, 5789.884202316014, 5850.473457388855, 9344.766380840261, 9448.12318200312, 9481.051894810464, 9539.809203816023, 9719.17387022111, 9721.854172187564, 9764.414135151914, 9794.216462682825, 9857.260705446977, 9900.702978910644, 7497.550146991198, 7558.962205188939, 7559.433042521943, 7641.885371719318, 7697.114831794192, 8124.878126828221, 8279.83440331178, 8285.295749861329, 8292.58537073156, 8295.709650162215, 7409.740659076906, 7430.331270185709, 7522.661480233293, 7662.923370766221, 7887.684492620231, 7313.062038559892, 7418.814529636802, 7430.0, 7460.3658689012045, 7526.360259378014, 6334.5430550972615, 6459.677016149268, 6471.0, 6477.060826180272, 6481.708323125376, 4749.26386410107, 4918.655694101379, 4939.357443767711, 4989.35138432016, 4996.375453068366, 4911.901761964812, 4915.7542122893, 5011.649184557046, 5032.6225533084435, 5035.244713293036], "value": 4558.310051737725, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.23879372243306, 338.8356647026193, 342.9931401371971, 343.7044142037847, 346.321210427562, 5265.86835329117, 5406.729663516828, 5426.918596221055, 5498.257735205746, 5562.276904002484, 5234.895302093965, 5317.760700768475, 5342.5993050521265, 5349.7057661828585, 5408.4050754416985, 4166.937495937564, 4223.72545784523, 4250.001249706316, 4279.459394617935, 4281.229378711831, 4138.855140070098, 4213.47331583552, 4246.80889359978, 4279.40088387626, 4289.978550107245, 4200.936985945214, 4206.663466922639, 4207.85272515462, 4221.662267018631, 4229.365595160735, 4203.579642035787, 4208.705390622657, 4227.816211460796, 4237.4915010198665, 4248.617624413818, 3708.2398108387715, 3769.5288088988877, 3791.3554695701796, 3806.1816709407613, 3817.675497582709, 5236.7119808410525, 5241.580673546146, 5247.344081989751, 5248.8687782805355, 5249.0, 4831.299461578052, 4853.854384368439, 4859.684120532154, 4884.560389564921, 4885.804567817283, 5469.808556700496, 5550.4449555044175, 5586.944130558723, 5587.373934250895, 5614.214010038598, 4101.487314085739, 4110.547839737656, 4114.362273847559, 4121.0, 4153.584641535822, 5806.303243610751, 5809.506191973687, 5811.099279611667, 5817.214676018725, 5885.881082810185, 4141.689373296955, 4228.450301460791, 4249.3413520904305, 4259.21204577148, 4264.616184543344, 4242.0455397535925, 4248.851290204828, 4271.658267338606, 4276.401303817468, 4294.82820687169, 4809.110314591811, 4823.686460380064, 4828.227483602606, 4832.710037397767, 4841.419029716457, 5386.784528618811, 5606.775728970795, 5615.006672631157, 5633.126865335879, 5642.984262832648, 1425.5580769961346, 1448.761309080742, 1449.9202543859979, 1452.7094581083825, 1452.847451017649, 881.6076845803556, 909.4725059465494, 919.1497864475333, 926.6247169896203, 939.6382392778829, 4722.197226471508, 4729.351563124661, 4736.952630473651, 4737.715737055788, 4769.95230047702, 5006.599472042228, 5007.798128449146, 5008.348914641147, 5023.748812559357, 5058.241263810384, 4754.334393184957, 4783.966814103992, 4799.712017278975, 4830.227163653799, 5017.949820501748, 2963.303623648441, 3028.273883886208, 3032.9839503766484, 3036.5596988436555, 3052.4658184818013, 5893.528517718572, 5898.84972430372, 5906.2912450505355, 5916.792912248051, 5928.347881733092, 5570.470805273492, 5817.301923769175, 5847.0, 5861.941380586225, 5876.794312199138, 5867.0, 5877.294724633071, 5889.469947704727, 5896.262967129109, 5913.319968203626, 5568.888622227451, 5678.290213723285, 5708.600397972102, 5720.34110108064, 5727.427257274239, 5690.601657883908, 5719.5138413235345, 5748.885022299447, 5761.539076873756, 5783.789996551954, 5934.6735929522565, 5981.401859814157, 5992.43071908168, 6009.819705408845, 6012.368701286302, 3849.9615003849603, 3906.492156019813, 4062.532808726916, 4115.773632450244, 4125.64931980785, 5734.369219385948, 5745.91381129275, 5748.913766293425, 5751.865233447865, 5769.59612827098, 5625.831225063254, 5662.745176467151, 5662.943370566406, 5682.14767784819, 5713.685747283939, 5411.756470958895, 5639.661620302631, 5640.830775076754, 5654.15187721845, 5670.177824215548, 5616.714222179907, 5639.182318563703, 5654.717264136694, 5669.3480249770155, 5673.943260567342, 5469.507744303032, 5667.319921609434, 5696.401877802937, 5704.857378565403, 5710.114932185518, 5520.917186242129, 5528.944710552843, 5534.280543529316, 5541.251930989265, 5592.3848376677715], "value": 4262.031875237954, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.7819914925947, 816.7715715914159, 822.9433842680162, 829.067299288301, 829.7510746775965, 13162.407691653874, 13309.068365214438, 13431.261280629573, 13442.0, 13512.527061552848, 11565.710857228574, 13965.79051314231, 14018.929905350484, 14170.220637864913, 14228.146311221333, 777.3392616276149, 783.0837919634042, 783.9372850171973, 783.9451238413313, 783.9764807055798, 804.4007214625112, 806.681360862459, 807.0114110214998, 807.0517142357736, 807.184743409158, 849.0829903704016, 849.6006876767909, 850.3282406898543, 850.8978922529305, 850.9829803403928, 850.4684572142411, 851.748734123435, 851.8977722673256, 852.4459101583958, 852.897652281727, 613.5858295650418, 614.0298328640737, 614.1310046284502, 614.241411856357, 614.2874265851591, 13565.728685426335, 13658.931705341509, 13660.0, 13682.726345473035, 13719.657008574766, 13706.725865482735, 13994.300284985811, 14360.281985900663, 14393.928030359886, 14428.783568246485, 11246.887531124748, 11284.830727539094, 11298.265612735227, 11363.715907102305, 11364.602238921598, 3740.2706472237924, 3755.530558680165, 3763.5107436033413, 3793.487879136309, 3815.8473661053526, 62763.372366276664, 63236.0, 64444.355556444774, 64521.67739161274, 64913.3508664912, 10983.780324393467, 11104.500297486633, 11132.332060076422, 11291.040261577693, 11447.25592836463, 20933.476663083544, 21281.148754049973, 21308.680369794467, 21322.36032919015, 21336.573268534543, 7593.810154746176, 7669.769906902802, 7904.0910295315625, 8026.398020148512, 8276.917230827736, 4569.360289559464, 4573.0, 4673.906521869543, 4726.291056341576, 4879.048585525859, 3337.6829201225846, 3435.484677298375, 3440.535527703728, 3443.896683099511, 3444.7588668793446, 574.1359254322218, 581.0673868441176, 585.487698264019, 594.2126682146173, 595.3480938372476, 585.7217821534822, 660.1451120798578, 684.9006894000441, 705.206642527157, 721.3760097515611, 9232.723018309462, 9238.445693258425, 9312.603426578293, 9383.577739001761, 9434.90565094354, 706.2972342519124, 722.5772922840198, 723.3345322303494, 727.9344858962613, 733.9119305683353, 4297.269464191095, 4512.2554778461845, 4640.86077417678, 4661.347411362412, 4741.644376671695, 86388.56805715931, 88917.55541222253, 89150.0, 89771.55114224387, 90616.54691726631, 48846.0, 48956.51043489591, 49961.25058124131, 50514.242286365734, 81129.78305325424, 67738.9839152413, 68095.65952170208, 70502.29497704958, 70952.64523677452, 71715.6414217936, 8720.476771393483, 8725.0, 8974.955125224333, 9013.324000699842, 9059.68291109808, 42318.57681423146, 44506.3324050146, 45719.08561828678, 45757.77121114373, 49142.50857491522, 40694.79652601718, 56221.15668264897, 56311.15533266922, 59120.70439647774, 61383.38616613777, 12468.625941221779, 12489.93755031219, 12510.249385036926, 12529.436175372313, 12588.370581470706, 14000.526522320335, 14063.789043164565, 14092.577222683336, 14261.215633139862, 14402.567922962327, 13256.867431325563, 13262.867371326163, 13359.1316564423, 13652.65868353299, 13813.447462101805, 12112.469389171394, 12302.569410070604, 12388.256704597752, 12588.87411125877, 13026.609201723963, 11695.649130526097, 12212.938935305267, 12322.568710095104, 12527.18573292733, 13244.072914895865, 10540.367577945348, 10817.242793004414, 10831.404272765074, 10889.183311251529, 10951.0, 10775.568977240822, 11299.43502824872, 11345.205835591429, 11395.544178232778, 11487.0], "value": 7007.359855236894, "unit": "score"}], "name": "dromaeo_css", "value": 7093.241318146112, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 114.0, 113.0, 113.0, 113.0, 114.0, 111.0, 112.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 121.0, 122.0, 170.0, 129.0, 123.0, 124.0, 124.0, 155.0, 124.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 161.0, 162.0, 162.0, 161.0, 161.0, 164.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 107.0, 75.0, 75.0, 75.0, 76.0, 97.0, 75.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 117.0, 83.0, 82.0, 82.0, 102.0, 82.0, 82.0, 117.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 116.0, 116.0, 116.0, 116.0, 116.0, 117.0], "value": 116.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 86.0, 85.0, 86.0, 86.0, 85.0, 86.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 51.0, 51.0, 54.0, 55.0, 53.0, 53.0, 52.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 79.0, 82.0, 83.0, 80.0, 80.0, 79.0, 88.0, 81.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 129.0, 133.0, 128.0, 129.0, 130.0, 128.0, 136.0, 180.0, 129.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 174.0, 164.0, 167.0, 168.0, 166.0, 165.0, 168.0, 165.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 67.0, 66.0, 63.0, 63.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1489.7000000000003, "alertThreshold": 2.0}]} 11:07:17 INFO - Return code: 0 11:07:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:07:17 INFO - # TBPL SUCCESS # 11:07:17 INFO - Running post-action listener: _resource_record_post_action 11:07:17 INFO - [mozharness: 2016-11-02 18:07:17.152696Z] Finished run-tests step (success) 11:07:17 INFO - Running post-run listener: _resource_record_post_run 11:07:17 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393060352; Read time: 84; Write time: 270284 11:07:17 INFO - TinderboxPrint: CPU usage
13.1% 11:07:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 84 11:07:17 INFO - TinderboxPrint: I/O write bytes / time
393,060,352 / 270,284 11:07:17 INFO - TinderboxPrint: CPU idle
8,286.7 (86.9%) 11:07:17 INFO - TinderboxPrint: CPU user
1,199.7 (12.6%) 11:07:17 INFO - TinderboxPrint: Swap in / out
0 / 0 11:07:17 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 105476096; Read time: 0; Write time: 97904 11:07:17 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287584256; Read time: 84; Write time: 172380 11:07:17 INFO - Running post-run listener: _upload_blobber_files 11:07:17 INFO - Blob upload gear active. 11:07:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:07:17 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 11:07:17 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'] 11:07:17 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 11:07:18 INFO - (blobuploader) - INFO - Open directory for files ... 11:07:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:07:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:07:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:07:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:07:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:07:18 INFO - (blobuploader) - INFO - Done attempting. 11:07:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:07:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:07:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:07:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:07:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:07:22 INFO - (blobuploader) - INFO - Done attempting. 11:07:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:07:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:07:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:07:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:07:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:07:23 INFO - (blobuploader) - INFO - Done attempting. 11:07:23 INFO - (blobuploader) - INFO - Iteration through files over. 11:07:23 INFO - Return code: 0 11:07:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:07:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:07:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/850bd6054038360f992a9f9051b535c01e20e784d4ae46637c2adbcbe80b5c238c60d185644c30f405fb587fbc764bfba87c9cec9b4075cccfe929aa160523d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac7083c210bc7ee868044002b8a0d99c172e6fb20c1676754e09ea3851af6cfb24991f1e1e36ed2b3285d0a9e64dd1f672cf549f863a3f1bd3b14812bc976823", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80f450301eaba04b363d8f12ebd16eb6b4772d429bf4c27455da892fabf30c74eb675cf1b97bdf42a71b5060c0919f468dac3d534f151f4dd00f6b4f7773650c"} 11:07:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:07:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:07:23 INFO - Contents: 11:07:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/850bd6054038360f992a9f9051b535c01e20e784d4ae46637c2adbcbe80b5c238c60d185644c30f405fb587fbc764bfba87c9cec9b4075cccfe929aa160523d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac7083c210bc7ee868044002b8a0d99c172e6fb20c1676754e09ea3851af6cfb24991f1e1e36ed2b3285d0a9e64dd1f672cf549f863a3f1bd3b14812bc976823", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80f450301eaba04b363d8f12ebd16eb6b4772d429bf4c27455da892fabf30c74eb675cf1b97bdf42a71b5060c0919f468dac3d534f151f4dd00f6b4f7773650c"} 11:07:23 INFO - Running post-run listener: copy_logs_to_upload_dir 11:07:23 INFO - Copying logs to upload dir... 11:07:23 INFO - mkdir: /builds/slave/test/build/upload/logs 11:07:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.902986 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-11-02 11:07:23.103086) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-02 11:07:23.107114) ========= 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=ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849 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/850bd6054038360f992a9f9051b535c01e20e784d4ae46637c2adbcbe80b5c238c60d185644c30f405fb587fbc764bfba87c9cec9b4075cccfe929aa160523d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac7083c210bc7ee868044002b8a0d99c172e6fb20c1676754e09ea3851af6cfb24991f1e1e36ed2b3285d0a9e64dd1f672cf549f863a3f1bd3b14812bc976823", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80f450301eaba04b363d8f12ebd16eb6b4772d429bf4c27455da892fabf30c74eb675cf1b97bdf42a71b5060c0919f468dac3d534f151f4dd00f6b4f7773650c"} build_url:https://queue.taskcluster.net/v1/task/C8nwRexxSxqmfHiWzbfb4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/C8nwRexxSxqmfHiWzbfb4g/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/850bd6054038360f992a9f9051b535c01e20e784d4ae46637c2adbcbe80b5c238c60d185644c30f405fb587fbc764bfba87c9cec9b4075cccfe929aa160523d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac7083c210bc7ee868044002b8a0d99c172e6fb20c1676754e09ea3851af6cfb24991f1e1e36ed2b3285d0a9e64dd1f672cf549f863a3f1bd3b14812bc976823", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80f450301eaba04b363d8f12ebd16eb6b4772d429bf4c27455da892fabf30c74eb675cf1b97bdf42a71b5060c0919f468dac3d534f151f4dd00f6b4f7773650c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-02 11:07:23.133119) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 11:07:23.133510) ========= 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=ed14279e38b05397cf4aa391000001a4-1478108803.753234-1244482849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 11:07:23.219403) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-02 11:07:23.219856) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-02 11:07:23.220181) ========= ========= Total master_lag: 0.17 =========