builder: cedar_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1478255770.61 results: success (0) buildid: 20161104022021 builduid: d8279fd5a4974685877346792f91cd6f revision: ad086fddd66a309a119289f62fb782aa51bec15d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-04 03:36:10.612287) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-04 03:36:10.612681) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-04 03:36:10.612949) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-04 03:36:10.658499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 03:36:10.658763) ========= 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=00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-04 03:36:10-- 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% 45.7M=0s 2016-11-04 03:36:11 (45.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090763 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 03:36:10.762946) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 03:36:10.763258) ========= 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=00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016777 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 03:36:10.813081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-04 03:36:10.813442) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev ad086fddd66a309a119289f62fb782aa51bec15d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev ad086fddd66a309a119289f62fb782aa51bec15d --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=00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-04 03:36:11,122 truncating revision to first 12 chars 2016-11-04 03:36:11,122 Setting DEBUG logging. 2016-11-04 03:36:11,123 attempt 1/10 2016-11-04 03:36:11,123 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/ad086fddd66a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-04 03:36:12,468 unpacking tar archive at: cedar-ad086fddd66a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.682356 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-04 03:36:12.510979) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-04 03:36:12.511386) ========= script_repo_revision: ad086fddd66a309a119289f62fb782aa51bec15d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-04 03:36:12.512019) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-04 03:36:12.512358) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-04 03:36:12.521314) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-04 03:36:12.521593) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] 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=00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:36:12 INFO - MultiFileLogger online at 20161104 03:36:12 in /builds/slave/test 03:36:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 03:36:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:36:12 INFO - {'append_to_log': False, 03:36:12 INFO - 'base_work_dir': '/builds/slave/test', 03:36:12 INFO - 'blob_upload_branch': 'Cedar', 03:36:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:36:12 INFO - 'branch': 'Cedar', 03:36:12 INFO - 'buildbot_json_path': 'buildprops.json', 03:36:12 INFO - 'config_files': ('talos/linux_config.py',), 03:36:12 INFO - 'default_actions': ('clobber', 03:36:12 INFO - 'read-buildbot-config', 03:36:12 INFO - 'download-and-extract', 03:36:12 INFO - 'populate-webroot', 03:36:12 INFO - 'create-virtualenv', 03:36:12 INFO - 'install', 03:36:12 INFO - 'run-tests'), 03:36:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:36:12 INFO - 'download_minidump_stackwalk': True, 03:36:12 INFO - 'download_symbols': 'ondemand', 03:36:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:36:12 INFO - 'tooltool.py': '/tools/tooltool.py', 03:36:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:36:12 INFO - '/tools/misc-python/virtualenv.py')}, 03:36:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:36:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:36:12 INFO - 'installer_path': 'installer.exe', 03:36:12 INFO - 'log_level': 'info', 03:36:12 INFO - 'log_name': 'talos', 03:36:12 INFO - 'log_to_console': True, 03:36:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:36:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:36:12 INFO - 'opt_config_files': (), 03:36:12 INFO - 'pip_index': False, 03:36:12 INFO - 'sps_profile': False, 03:36:12 INFO - 'sps_profile_interval': 0, 03:36:12 INFO - 'suite': 'dromaeojs', 03:36:12 INFO - 'system_bits': '32', 03:36:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:36:12 INFO - 'title': 'talos-linux64-ix-016', 03:36:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:36:12 INFO - 'use_talos_json': True, 03:36:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:36:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:36:12 INFO - 'work_dir': 'build'} 03:36:12 INFO - [mozharness: 2016-11-04 10:36:12.928458Z] Running clobber step. 03:36:12 INFO - Running pre-action listener: _resource_record_pre_action 03:36:12 INFO - Running main action method: clobber 03:36:12 INFO - rmtree: /builds/slave/test/build 03:36:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:36:13 INFO - Running post-action listener: _resource_record_post_action 03:36:13 INFO - [mozharness: 2016-11-04 10:36:13.396452Z] Finished clobber step (success) 03:36:13 INFO - [mozharness: 2016-11-04 10:36:13.396563Z] Running read-buildbot-config step. 03:36:13 INFO - Running pre-action listener: _resource_record_pre_action 03:36:13 INFO - Running main action method: read_buildbot_config 03:36:13 INFO - Using buildbot properties: 03:36:13 INFO - { 03:36:13 INFO - "project": "", 03:36:13 INFO - "product": "firefox", 03:36:13 INFO - "script_repo_revision": "default", 03:36:13 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs", 03:36:13 INFO - "repository": "", 03:36:13 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs", 03:36:13 INFO - "buildid": "20161104022021", 03:36:13 INFO - "pgo_build": "False", 03:36:13 INFO - "basedir": "/builds/slave/test", 03:36:13 INFO - "buildnumber": 1, 03:36:13 INFO - "slavename": "talos-linux64-ix-016", 03:36:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:36:13 INFO - "platform": "ubuntu64_hw", 03:36:13 INFO - "scheduler": "tests-cedar-linux64-talos", 03:36:13 INFO - "branch": "cedar", 03:36:13 INFO - "repo_path": "projects/cedar", 03:36:13 INFO - "revision": "ad086fddd66a309a119289f62fb782aa51bec15d", 03:36:13 INFO - "stage_platform": "linux64", 03:36:13 INFO - "builduid": "d8279fd5a4974685877346792f91cd6f", 03:36:13 INFO - "slavebuilddir": "test" 03:36:13 INFO - } 03:36:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 03:36:13 INFO - Running post-action listener: _resource_record_post_action 03:36:13 INFO - [mozharness: 2016-11-04 10:36:13.399353Z] Finished read-buildbot-config step (success) 03:36:13 INFO - [mozharness: 2016-11-04 10:36:13.399452Z] Running download-and-extract step. 03:36:13 INFO - Running pre-action listener: _resource_record_pre_action 03:36:13 INFO - Running main action method: download_and_extract 03:36:13 INFO - mkdir: /builds/slave/test/build/tests 03:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:13 INFO - trying https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:36:13 INFO - Downloading https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/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 03:36:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/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 03:36:14 INFO - Downloaded 1361 bytes. 03:36:14 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:36:14 INFO - Using the following test package requirements: 03:36:14 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:36:14 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:36:14 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:36:14 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:14 INFO - u'jsshell-linux-x86_64.zip'], 03:36:14 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:36:14 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:36:14 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:36:14 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:36:14 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:36:14 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:36:14 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:36:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:36:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:36:14 INFO - Fetch https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:36:14 INFO - Http code: 200 03:36:14 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 03:36:14 INFO - x-amz-cf-id: myg0t-EFfHK5jHZWUrUOLQr2xo9kFCuET23WBKuByFigo2EgJ6rkGQ== 03:36:14 INFO - x-amz-version-id: mG0R0JNormGQAuT3k7j9OHVYr12n9sDs 03:36:14 INFO - Expected file size: 20443248 03:36:14 INFO - Obtained file size: 20443248 03:36:18 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 03:36:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:36:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:36:18 INFO - Fetch https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:36:19 INFO - Http code: 200 03:36:19 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 03:36:19 INFO - x-amz-cf-id: gc6W8bJtb3qlDH2IhQ0twRIPbyVjTZ12xCZINz--xaPi0Ex2JB7v0g== 03:36:19 INFO - x-amz-version-id: mG0R0JNormGQAuT3k7j9OHVYr12n9sDs 03:36:19 INFO - Expected file size: 20443248 03:36:19 INFO - Obtained file size: 20443248 03:36:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 03:36:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:36:24 INFO - Fetch https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:36:24 INFO - Http code: 200 03:36:24 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 03:36:24 INFO - x-amz-cf-id: fARZtAdrm_0XJC9N-s-Howw7xtxqzFo-jBR1sdC6WUEXnDApIFHwdQ== 03:36:24 INFO - x-amz-version-id: CYIGKdRFYzZhYycxtXguO7kp3APoeT9Y 03:36:25 INFO - Expected file size: 14409038 03:36:25 INFO - Obtained file size: 14409038 03:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:25 INFO - trying https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:36:25 INFO - Downloading https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/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 03:36:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/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 03:36:27 INFO - Downloaded 55835683 bytes. 03:36:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:36:27 INFO - mkdir: /builds/slave/test/properties 03:36:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:36:27 INFO - Writing to file /builds/slave/test/properties/build_url 03:36:27 INFO - Contents: 03:36:27 INFO - build_url:https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:36:28 INFO - Running post-action listener: _resource_record_post_action 03:36:28 INFO - Running post-action listener: set_extra_try_arguments 03:36:28 INFO - [mozharness: 2016-11-04 10:36:28.251740Z] Finished download-and-extract step (success) 03:36:28 INFO - [mozharness: 2016-11-04 10:36:28.251966Z] Running populate-webroot step. 03:36:28 INFO - Running pre-action listener: _resource_record_pre_action 03:36:28 INFO - Running main action method: populate_webroot 03:36:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:36:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:36:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:36:28 INFO - '--tppagecycles', 03:36:28 INFO - '7'], 03:36:28 INFO - 'tests': ['tsvgm']}}, 03:36:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:36:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:36:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:36:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:36:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:36:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:36:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:28 INFO - 'talos_options': ['--disable-e10s'], 03:36:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:28 INFO - 'talos_options': ['--disable-e10s'], 03:36:28 INFO - 'tests': ['damp', 'tps']}, 03:36:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:28 INFO - 'tests': ['damp', 'tps']}, 03:36:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:36:28 INFO - 'tests': ['dromaeo_dom']}, 03:36:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:36:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:36:28 INFO - 'tests': ['basic_compositor_video']}, 03:36:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:36:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:36:28 INFO - 'tests': ['a11yr', 03:36:28 INFO - 'ts_paint', 03:36:28 INFO - 'tpaint', 03:36:28 INFO - 'sessionrestore', 03:36:28 INFO - 'sessionrestore_no_auto_restore', 03:36:28 INFO - 'tabpaint']}, 03:36:28 INFO - 'other-e10s': {'tests': ['a11yr', 03:36:28 INFO - 'ts_paint', 03:36:28 INFO - 'tpaint', 03:36:28 INFO - 'sessionrestore', 03:36:28 INFO - 'sessionrestore_no_auto_restore', 03:36:28 INFO - 'tabpaint']}, 03:36:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:36:28 INFO - 'ts_paint', 03:36:28 INFO - 'tpaint', 03:36:28 INFO - 'sessionrestore', 03:36:28 INFO - 'sessionrestore_no_auto_restore', 03:36:28 INFO - 'tabpaint']}, 03:36:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:36:28 INFO - 'ts_paint', 03:36:28 INFO - 'tpaint', 03:36:28 INFO - 'sessionrestore', 03:36:28 INFO - 'sessionrestore_no_auto_restore', 03:36:28 INFO - 'tabpaint']}, 03:36:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:36:28 INFO - 'tests': ['a11yr', 03:36:28 INFO - 'ts_paint', 03:36:28 INFO - 'tpaint', 03:36:28 INFO - 'sessionrestore', 03:36:28 INFO - 'sessionrestore_no_auto_restore', 03:36:28 INFO - 'tabpaint']}, 03:36:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:36:28 INFO - 'tests': ['a11yr', 03:36:28 INFO - 'ts_paint', 03:36:28 INFO - 'tpaint', 03:36:28 INFO - 'sessionrestore', 03:36:28 INFO - 'sessionrestore_no_auto_restore', 03:36:28 INFO - 'tabpaint']}, 03:36:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:36:28 INFO - 'tests': ['tsvgx', 03:36:28 INFO - 'tsvgr_opacity', 03:36:28 INFO - 'tart', 03:36:28 INFO - 'tscrollx', 03:36:28 INFO - 'cart']}, 03:36:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:36:28 INFO - 'tsvgr_opacity', 03:36:28 INFO - 'tart', 03:36:28 INFO - 'tscrollx', 03:36:28 INFO - 'cart']}, 03:36:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:28 INFO - 'talos_options': ['--disable-e10s'], 03:36:28 INFO - 'tests': ['tp5o']}, 03:36:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:28 INFO - 'tests': ['tp5o']}, 03:36:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:28 INFO - 'talos_options': ['--disable-e10s', 03:36:28 INFO - '--xperf_path', 03:36:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:28 INFO - 'tests': ['tp5n']}, 03:36:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:28 INFO - 'talos_options': ['--xperf_path', 03:36:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:28 INFO - 'tests': ['tp5n']}}, 03:36:28 INFO - 'talos.zip': {'path': '', 03:36:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:36:28 INFO - Running post-action listener: _resource_record_post_action 03:36:28 INFO - [mozharness: 2016-11-04 10:36:28.271959Z] Finished populate-webroot step (success) 03:36:28 INFO - [mozharness: 2016-11-04 10:36:28.272047Z] Running create-virtualenv step. 03:36:28 INFO - Running pre-action listener: _resource_record_pre_action 03:36:28 INFO - Running main action method: create_virtualenv 03:36:28 INFO - Creating virtualenv /builds/slave/test/build/venv 03:36:28 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 03:36:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:36:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:36:28 INFO - Using real prefix '/usr' 03:36:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:36:28 INFO - Installing distribute.............................................................................................................................................................................................done. 03:36:30 INFO - Installing pip.................done. 03:36:30 INFO - Return code: 0 03:36:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:36:31 INFO - Reading from file tmpfile_stdout 03:36:31 INFO - Output received: 03:36:31 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) 03:36:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:36:31 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')]} 03:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:31 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')]} 03:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:31 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 0x7f667ff75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1881790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187e930>, '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 0x187f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187fcc0>, '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': '00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788', '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 03:36:31 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 03:36:31 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 03:36:31 INFO - Using env: {'DISPLAY': ':0', 03:36:31 INFO - 'HOME': '/home/cltbld', 03:36:31 INFO - 'LANG': 'en_US.UTF-8', 03:36:31 INFO - 'LANGUAGE': 'en_US:en', 03:36:31 INFO - 'LOGNAME': 'cltbld', 03:36:31 INFO - 'MAIL': '/var/mail/cltbld', 03:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:31 INFO - 'MOZ_NO_REMOTE': '1', 03:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:31 INFO - 'NO_EM_RESTART': '1', 03:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:31 INFO - 'PWD': '/builds/slave/test', 03:36:31 INFO - 'SHELL': '/bin/bash', 03:36:31 INFO - 'SHLVL': '1', 03:36:31 INFO - 'TERM': 'linux', 03:36:31 INFO - 'TMOUT': '86400', 03:36:31 INFO - 'USER': 'cltbld', 03:36:31 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788', 03:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:31 INFO - '_': '/tools/buildbot/bin/python'} 03:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:31 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 03:36:31 INFO - Cleaning up... 03:36:31 INFO - Return code: 0 03:36:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:36:31 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')]} 03:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:31 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')]} 03:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:31 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 0x7f667ff75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1881790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187e930>, '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 0x187f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187fcc0>, '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': '00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788', '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 03:36:31 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 03:36:31 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 03:36:31 INFO - Using env: {'DISPLAY': ':0', 03:36:31 INFO - 'HOME': '/home/cltbld', 03:36:31 INFO - 'LANG': 'en_US.UTF-8', 03:36:31 INFO - 'LANGUAGE': 'en_US:en', 03:36:31 INFO - 'LOGNAME': 'cltbld', 03:36:31 INFO - 'MAIL': '/var/mail/cltbld', 03:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:31 INFO - 'MOZ_NO_REMOTE': '1', 03:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:31 INFO - 'NO_EM_RESTART': '1', 03:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:31 INFO - 'PWD': '/builds/slave/test', 03:36:31 INFO - 'SHELL': '/bin/bash', 03:36:31 INFO - 'SHLVL': '1', 03:36:31 INFO - 'TERM': 'linux', 03:36:31 INFO - 'TMOUT': '86400', 03:36:31 INFO - 'USER': 'cltbld', 03:36:31 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788', 03:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:31 INFO - '_': '/tools/buildbot/bin/python'} 03:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:31 INFO - Downloading/unpacking psutil>=3.1.1 03:36:31 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 03:36:31 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 03:36:31 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 03:36:31 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 03:36:31 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 03:36:31 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 03:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:36:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:33 INFO - Installing collected packages: psutil 03:36:33 INFO - Running setup.py install for psutil 03:36:33 INFO - building 'psutil._psutil_linux' extension 03:36:33 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 03:36:33 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 03:36:33 INFO - building 'psutil._psutil_posix' extension 03:36:33 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 03:36:33 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 03:36:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:34 INFO - Successfully installed psutil 03:36:34 INFO - Cleaning up... 03:36:34 INFO - Return code: 0 03:36:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f667ff75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1881790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187e930>, '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 0x187f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187fcc0>, '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': '00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788', '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 03:36:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:36:34 INFO - Using env: {'DISPLAY': ':0', 03:36:34 INFO - 'HOME': '/home/cltbld', 03:36:34 INFO - 'LANG': 'en_US.UTF-8', 03:36:34 INFO - 'LANGUAGE': 'en_US:en', 03:36:34 INFO - 'LOGNAME': 'cltbld', 03:36:34 INFO - 'MAIL': '/var/mail/cltbld', 03:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:34 INFO - 'MOZ_NO_REMOTE': '1', 03:36:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:34 INFO - 'NO_EM_RESTART': '1', 03:36:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:34 INFO - 'PWD': '/builds/slave/test', 03:36:34 INFO - 'SHELL': '/bin/bash', 03:36:34 INFO - 'SHLVL': '1', 03:36:34 INFO - 'TERM': 'linux', 03:36:34 INFO - 'TMOUT': '86400', 03:36:34 INFO - 'USER': 'cltbld', 03:36:34 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788', 03:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:34 INFO - '_': '/tools/buildbot/bin/python'} 03:36:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:36:36 INFO - Installing collected packages: mozsystemmonitor 03:36:36 INFO - Running setup.py install for mozsystemmonitor 03:36:36 INFO - Successfully installed mozsystemmonitor 03:36:36 INFO - Cleaning up... 03:36:36 INFO - Return code: 0 03:36:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:36:36 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')]} 03:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:36 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')]} 03:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:36 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 0x7f667ff75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1881790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187e930>, '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 0x187f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187fcc0>, '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': '00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788', '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 03:36:36 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 03:36:36 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 03:36:36 INFO - Using env: {'DISPLAY': ':0', 03:36:36 INFO - 'HOME': '/home/cltbld', 03:36:36 INFO - 'LANG': 'en_US.UTF-8', 03:36:36 INFO - 'LANGUAGE': 'en_US:en', 03:36:36 INFO - 'LOGNAME': 'cltbld', 03:36:36 INFO - 'MAIL': '/var/mail/cltbld', 03:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:36 INFO - 'MOZ_NO_REMOTE': '1', 03:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:36 INFO - 'NO_EM_RESTART': '1', 03:36:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:36 INFO - 'PWD': '/builds/slave/test', 03:36:36 INFO - 'SHELL': '/bin/bash', 03:36:36 INFO - 'SHLVL': '1', 03:36:36 INFO - 'TERM': 'linux', 03:36:36 INFO - 'TMOUT': '86400', 03:36:36 INFO - 'USER': 'cltbld', 03:36:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788', 03:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:36 INFO - '_': '/tools/buildbot/bin/python'} 03:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:36 INFO - Downloading/unpacking jsonschema==2.5.1 03:36:36 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 03:36:36 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 03:36:36 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 03:36:36 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 03:36:36 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 03:36:36 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 03:36:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:36:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:36:38 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 03:36:38 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 03:36:38 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 03:36:38 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 03:36:38 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 03:36:38 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 03:36:38 INFO - Downloading functools32-3.2.3-2.tar.gz 03:36:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:36:38 INFO - warning: no files found matching '*.txt' 03:36:38 INFO - no previously-included directories found matching 'build' 03:36:38 INFO - no previously-included directories found matching 'dist' 03:36:38 INFO - no previously-included directories found matching '.git*' 03:36:38 INFO - Installing collected packages: jsonschema, functools32 03:36:38 INFO - Running setup.py install for functools32 03:36:38 INFO - warning: no files found matching '*.txt' 03:36:38 INFO - no previously-included directories found matching 'build' 03:36:38 INFO - no previously-included directories found matching 'dist' 03:36:38 INFO - no previously-included directories found matching '.git*' 03:36:38 INFO - Successfully installed jsonschema functools32 03:36:38 INFO - Cleaning up... 03:36:39 INFO - Return code: 0 03:36:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:36: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')]} 03:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36: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')]} 03:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f667ff75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1881790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187e930>, '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 0x187f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187fcc0>, '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': '00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788', '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 03:36:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:36:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:36:39 INFO - Using env: {'DISPLAY': ':0', 03:36:39 INFO - 'HOME': '/home/cltbld', 03:36:39 INFO - 'LANG': 'en_US.UTF-8', 03:36:39 INFO - 'LANGUAGE': 'en_US:en', 03:36:39 INFO - 'LOGNAME': 'cltbld', 03:36:39 INFO - 'MAIL': '/var/mail/cltbld', 03:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:39 INFO - 'MOZ_NO_REMOTE': '1', 03:36:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:39 INFO - 'NO_EM_RESTART': '1', 03:36:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:39 INFO - 'PWD': '/builds/slave/test', 03:36:39 INFO - 'SHELL': '/bin/bash', 03:36:39 INFO - 'SHLVL': '1', 03:36:39 INFO - 'TERM': 'linux', 03:36:39 INFO - 'TMOUT': '86400', 03:36:39 INFO - 'USER': 'cltbld', 03:36:39 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788', 03:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:39 INFO - '_': '/tools/buildbot/bin/python'} 03:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:36:39 INFO - Cleaning up... 03:36:39 INFO - Return code: 0 03:36:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:36: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')]} 03:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36: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')]} 03:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f667ff75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1881790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187e930>, '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 0x187f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187fcc0>, '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': '00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788', '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 03:36:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:36:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:36:39 INFO - Using env: {'DISPLAY': ':0', 03:36:39 INFO - 'HOME': '/home/cltbld', 03:36:39 INFO - 'LANG': 'en_US.UTF-8', 03:36:39 INFO - 'LANGUAGE': 'en_US:en', 03:36:39 INFO - 'LOGNAME': 'cltbld', 03:36:39 INFO - 'MAIL': '/var/mail/cltbld', 03:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:39 INFO - 'MOZ_NO_REMOTE': '1', 03:36:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:39 INFO - 'NO_EM_RESTART': '1', 03:36:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:39 INFO - 'PWD': '/builds/slave/test', 03:36:39 INFO - 'SHELL': '/bin/bash', 03:36:39 INFO - 'SHLVL': '1', 03:36:39 INFO - 'TERM': 'linux', 03:36:39 INFO - 'TMOUT': '86400', 03:36:39 INFO - 'USER': 'cltbld', 03:36:39 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788', 03:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:39 INFO - '_': '/tools/buildbot/bin/python'} 03:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:39 INFO - Downloading/unpacking blobuploader==1.2.4 03:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:41 INFO - Downloading blobuploader-1.2.4.tar.gz 03:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:36:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:36:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:42 INFO - Downloading docopt-0.6.1.tar.gz 03:36:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:36:42 INFO - Installing collected packages: blobuploader, requests, docopt 03:36:42 INFO - Running setup.py install for blobuploader 03:36:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:36:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:36:42 INFO - Running setup.py install for requests 03:36:42 INFO - Running setup.py install for docopt 03:36:42 INFO - Successfully installed blobuploader requests docopt 03:36:42 INFO - Cleaning up... 03:36:42 INFO - Return code: 0 03:36:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:42 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 0x7f667ff75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1881790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187e930>, '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 0x187f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187fcc0>, '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': '00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788', '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 03:36:42 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 03:36:42 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 03:36:42 INFO - Using env: {'DISPLAY': ':0', 03:36:42 INFO - 'HOME': '/home/cltbld', 03:36:42 INFO - 'LANG': 'en_US.UTF-8', 03:36:42 INFO - 'LANGUAGE': 'en_US:en', 03:36:42 INFO - 'LOGNAME': 'cltbld', 03:36:42 INFO - 'MAIL': '/var/mail/cltbld', 03:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:42 INFO - 'MOZ_NO_REMOTE': '1', 03:36:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:42 INFO - 'NO_EM_RESTART': '1', 03:36:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:42 INFO - 'PWD': '/builds/slave/test', 03:36:42 INFO - 'SHELL': '/bin/bash', 03:36:42 INFO - 'SHLVL': '1', 03:36:42 INFO - 'TERM': 'linux', 03:36:42 INFO - 'TMOUT': '86400', 03:36:42 INFO - 'USER': 'cltbld', 03:36:42 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788', 03:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:42 INFO - '_': '/tools/buildbot/bin/python'} 03:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:43 INFO - Running setup.py (path:/tmp/pip-gVKTeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:43 INFO - Running setup.py (path:/tmp/pip-DTXhto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:43 INFO - Running setup.py (path:/tmp/pip-OICGwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:43 INFO - Running setup.py (path:/tmp/pip-L6A5WZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:43 INFO - Running setup.py (path:/tmp/pip-ZVbYAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:43 INFO - Running setup.py (path:/tmp/pip-AZPvO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:43 INFO - Running setup.py (path:/tmp/pip-1EbbnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:43 INFO - Running setup.py (path:/tmp/pip-97WYZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:43 INFO - Running setup.py (path:/tmp/pip-nbSlLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:43 INFO - Running setup.py (path:/tmp/pip-R_Y9Gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:43 INFO - Running setup.py (path:/tmp/pip-QzyU2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:43 INFO - Running setup.py (path:/tmp/pip-oF52XT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:43 INFO - Running setup.py (path:/tmp/pip-6p2UXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:43 INFO - Running setup.py (path:/tmp/pip-s3CLvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:44 INFO - Running setup.py (path:/tmp/pip-IAxD2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:44 INFO - Running setup.py (path:/tmp/pip-68gVlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:44 INFO - Running setup.py (path:/tmp/pip-5U4Jx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:36:44 INFO - Running setup.py install for manifestparser 03:36:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:36:44 INFO - Running setup.py install for mozcrash 03:36:44 INFO - Running setup.py install for mozdebug 03:36:44 INFO - Running setup.py install for mozdevice 03:36:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:36:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:36:44 INFO - Running setup.py install for mozfile 03:36:44 INFO - Running setup.py install for mozhttpd 03:36:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:36:44 INFO - Running setup.py install for mozinfo 03:36:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:36:44 INFO - Running setup.py install for mozInstall 03:36:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:36:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:36:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:36:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:36:45 INFO - Running setup.py install for mozleak 03:36:45 INFO - Running setup.py install for mozlog 03:36:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:36:45 INFO - Running setup.py install for moznetwork 03:36:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:36:45 INFO - Running setup.py install for mozprocess 03:36:45 INFO - Running setup.py install for mozprofile 03:36:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:36:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:36:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:36:45 INFO - Running setup.py install for mozrunner 03:36:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:36:45 INFO - Running setup.py install for mozscreenshot 03:36:45 INFO - Running setup.py install for moztest 03:36:45 INFO - Running setup.py install for mozversion 03:36:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:36:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:36:46 INFO - Cleaning up... 03:36:46 INFO - Return code: 0 03:36:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36: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')]} 03:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36: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')]} 03:36:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:46 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 0x7f667ff75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1881790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187e930>, '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 0x187f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187fcc0>, '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': '00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788', '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 03:36:46 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 03:36:46 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 03:36:46 INFO - Using env: {'DISPLAY': ':0', 03:36:46 INFO - 'HOME': '/home/cltbld', 03:36:46 INFO - 'LANG': 'en_US.UTF-8', 03:36:46 INFO - 'LANGUAGE': 'en_US:en', 03:36:46 INFO - 'LOGNAME': 'cltbld', 03:36:46 INFO - 'MAIL': '/var/mail/cltbld', 03:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:46 INFO - 'MOZ_NO_REMOTE': '1', 03:36:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:46 INFO - 'NO_EM_RESTART': '1', 03:36:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:46 INFO - 'PWD': '/builds/slave/test', 03:36:46 INFO - 'SHELL': '/bin/bash', 03:36:46 INFO - 'SHLVL': '1', 03:36:46 INFO - 'TERM': 'linux', 03:36:46 INFO - 'TMOUT': '86400', 03:36:46 INFO - 'USER': 'cltbld', 03:36:46 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788', 03:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:46 INFO - '_': '/tools/buildbot/bin/python'} 03:36:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:46 INFO - Running setup.py (path:/tmp/pip-T9GFsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:46 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)) 03:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:46 INFO - Running setup.py (path:/tmp/pip-732U5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:46 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)) 03:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:46 INFO - Running setup.py (path:/tmp/pip-uTtfTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:46 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)) 03:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:46 INFO - Running setup.py (path:/tmp/pip-Fw3UZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:46 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)) 03:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:46 INFO - Running setup.py (path:/tmp/pip-BGBxnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:46 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)) 03:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:46 INFO - Running setup.py (path:/tmp/pip-K2ga3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:46 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)) 03:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:46 INFO - Running setup.py (path:/tmp/pip-mIJWld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:46 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)) 03:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:46 INFO - Running setup.py (path:/tmp/pip-88l7Xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:46 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)) 03:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:46 INFO - Running setup.py (path:/tmp/pip-jhMYXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:46 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)) 03:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:46 INFO - Running setup.py (path:/tmp/pip-Q3DgKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:46 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)) 03:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:46 INFO - Running setup.py (path:/tmp/pip-RrWmPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:47 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)) 03:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:47 INFO - Running setup.py (path:/tmp/pip-h0IUlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:47 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)) 03:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:47 INFO - Running setup.py (path:/tmp/pip-DVXiuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:47 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)) 03:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:47 INFO - Running setup.py (path:/tmp/pip-RsZMXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:47 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)) 03:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:47 INFO - Running setup.py (path:/tmp/pip-DVL6UQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:47 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)) 03:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:47 INFO - Running setup.py (path:/tmp/pip-b33whf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:47 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)) 03:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:47 INFO - Running setup.py (path:/tmp/pip-oRH3Kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:47 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)) 03:36:47 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)) 03:36:47 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)) 03:36:47 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)) 03:36:47 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)) 03:36:47 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)) 03:36:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:36:47 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 03:36:47 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 03:36:47 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 03:36:47 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 03:36:47 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 03:36:47 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 03:36:49 INFO - Downloading blessings-1.6.tar.gz 03:36:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:36:49 INFO - Installing collected packages: blessings 03:36:49 INFO - Running setup.py install for blessings 03:36:49 INFO - Successfully installed blessings 03:36:49 INFO - Cleaning up... 03:36:49 INFO - Return code: 0 03:36:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:36:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:36:49 INFO - Reading from file tmpfile_stdout 03:36:49 INFO - Current package versions: 03:36:49 INFO - argparse == 1.2.1 03:36:49 INFO - blessings == 1.6 03:36:49 INFO - blobuploader == 1.2.4 03:36:49 INFO - docopt == 0.6.1 03:36:49 INFO - functools32 == 3.2.3-2 03:36:49 INFO - jsonschema == 2.5.1 03:36:49 INFO - manifestparser == 1.1 03:36:49 INFO - mozInstall == 1.12 03:36:49 INFO - mozcrash == 0.17 03:36:49 INFO - mozdebug == 0.1 03:36:49 INFO - mozdevice == 0.48 03:36:49 INFO - mozfile == 1.2 03:36:49 INFO - mozhttpd == 0.7 03:36:49 INFO - mozinfo == 0.9 03:36:49 INFO - mozleak == 0.1 03:36:49 INFO - mozlog == 3.4 03:36:49 INFO - moznetwork == 0.27 03:36:49 INFO - mozprocess == 0.23 03:36:49 INFO - mozprofile == 0.28 03:36:49 INFO - mozrunner == 6.12 03:36:49 INFO - mozscreenshot == 0.1 03:36:49 INFO - mozsystemmonitor == 0.3 03:36:49 INFO - moztest == 0.7 03:36:49 INFO - mozversion == 1.4 03:36:49 INFO - psutil == 3.1.1 03:36:49 INFO - requests == 1.2.3 03:36:49 INFO - wsgiref == 0.1.2 03:36:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:49 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 0x7f667ff75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1881790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187e930>, '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 0x187f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187fcc0>, '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': '00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788', '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 03:36:49 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 03:36:49 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 03:36:49 INFO - Using env: {'DISPLAY': ':0', 03:36:49 INFO - 'HOME': '/home/cltbld', 03:36:49 INFO - 'LANG': 'en_US.UTF-8', 03:36:49 INFO - 'LANGUAGE': 'en_US:en', 03:36:49 INFO - 'LOGNAME': 'cltbld', 03:36:49 INFO - 'MAIL': '/var/mail/cltbld', 03:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:49 INFO - 'MOZ_NO_REMOTE': '1', 03:36:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:49 INFO - 'NO_EM_RESTART': '1', 03:36:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:49 INFO - 'PWD': '/builds/slave/test', 03:36:49 INFO - 'SHELL': '/bin/bash', 03:36:49 INFO - 'SHLVL': '1', 03:36:49 INFO - 'TERM': 'linux', 03:36:49 INFO - 'TMOUT': '86400', 03:36:49 INFO - 'USER': 'cltbld', 03:36:49 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788', 03:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:49 INFO - '_': '/tools/buildbot/bin/python'} 03:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:50 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)) 03:36:50 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)) 03:36:50 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)) 03:36:50 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)) 03:36:50 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)) 03:36:50 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)) 03:36:50 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)) 03:36:50 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)) 03:36:50 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)) 03:36:50 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)) 03:36:50 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)) 03:36:50 INFO - Cleaning up... 03:36:50 INFO - Return code: 0 03:36:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:36:50 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')]} 03:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:50 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')]} 03:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:50 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 0x7f667ff75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1881790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187e930>, '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 0x187f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187fcc0>, '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': '00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788', '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 03:36:50 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 03:36:50 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 03:36:50 INFO - Using env: {'DISPLAY': ':0', 03:36:50 INFO - 'HOME': '/home/cltbld', 03:36:50 INFO - 'LANG': 'en_US.UTF-8', 03:36:50 INFO - 'LANGUAGE': 'en_US:en', 03:36:50 INFO - 'LOGNAME': 'cltbld', 03:36:50 INFO - 'MAIL': '/var/mail/cltbld', 03:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:50 INFO - 'MOZ_NO_REMOTE': '1', 03:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:50 INFO - 'NO_EM_RESTART': '1', 03:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:50 INFO - 'PWD': '/builds/slave/test', 03:36:50 INFO - 'SHELL': '/bin/bash', 03:36:50 INFO - 'SHLVL': '1', 03:36:50 INFO - 'TERM': 'linux', 03:36:50 INFO - 'TMOUT': '86400', 03:36:50 INFO - 'USER': 'cltbld', 03:36:50 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788', 03:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:50 INFO - '_': '/tools/buildbot/bin/python'} 03:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:36:50 INFO - Cleaning up... 03:36:50 INFO - Return code: 0 03:36:50 INFO - Running post-action listener: _resource_record_post_action 03:36:50 INFO - Running post-action listener: _start_resource_monitoring 03:36:50 INFO - Starting resource monitoring. 03:36:50 INFO - [mozharness: 2016-11-04 10:36:50.394418Z] Finished create-virtualenv step (success) 03:36:50 INFO - [mozharness: 2016-11-04 10:36:50.394920Z] Running install step. 03:36:50 INFO - Running pre-action listener: _resource_record_pre_action 03:36:50 INFO - Running main action method: install 03:36:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:36:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:36:50 INFO - Reading from file tmpfile_stdout 03:36:50 INFO - Detecting whether we're running mozinstall >=1.0... 03:36:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:36:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:36:50 INFO - Reading from file tmpfile_stdout 03:36:50 INFO - Output received: 03:36:50 INFO - Usage: mozinstall [options] installer 03:36:50 INFO - Options: 03:36:50 INFO - -h, --help show this help message and exit 03:36:50 INFO - -d DEST, --destination=DEST 03:36:50 INFO - Directory to install application into. [default: 03:36:50 INFO - "/builds/slave/test"] 03:36:50 INFO - --app=APP Application being installed. [default: firefox] 03:36:50 INFO - mkdir: /builds/slave/test/build/application 03:36:50 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'] 03:36:50 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 03:37:06 INFO - Reading from file tmpfile_stdout 03:37:06 INFO - Output received: 03:37:06 INFO - /builds/slave/test/build/application/firefox/firefox 03:37:06 INFO - Running post-action listener: _resource_record_post_action 03:37:06 INFO - [mozharness: 2016-11-04 10:37:06.771686Z] Finished install step (success) 03:37:06 INFO - [mozharness: 2016-11-04 10:37:06.771931Z] Running run-tests step. 03:37:06 INFO - Running pre-action listener: _resource_record_pre_action 03:37:06 INFO - Running main action method: run_tests 03:37:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:37:06 INFO - Python 2.7.3 03:37:06 INFO - Return code: 0 03:37:06 INFO - grabbing minidump binary from tooltool 03:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:06 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 0x187e930>, '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 0x187f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187fcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:37:06 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 03:37:06 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 03:37:06 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 03:37:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:37:06 INFO - Return code: 0 03:37:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:37:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:37:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:37:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:37:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:37:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 03:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 03:37:06 INFO - Using env: {'DISPLAY': ':0', 03:37:06 INFO - 'HOME': '/home/cltbld', 03:37:06 INFO - 'LANG': 'en_US.UTF-8', 03:37:06 INFO - 'LANGUAGE': 'en_US:en', 03:37:06 INFO - 'LOGNAME': 'cltbld', 03:37:06 INFO - 'MAIL': '/var/mail/cltbld', 03:37:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:37:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:06 INFO - 'MOZ_NO_REMOTE': '1', 03:37:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:06 INFO - 'NO_EM_RESTART': '1', 03:37:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:06 INFO - 'PWD': '/builds/slave/test', 03:37:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:37:06 INFO - 'SHELL': '/bin/bash', 03:37:06 INFO - 'SHLVL': '1', 03:37:06 INFO - 'TERM': 'linux', 03:37:06 INFO - 'TMOUT': '86400', 03:37:06 INFO - 'USER': 'cltbld', 03:37:06 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788', 03:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:06 INFO - '_': '/tools/buildbot/bin/python'} 03:37:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 03:37:07 INFO - mozversion application_buildid: 20161104022021 03:37:07 INFO - mozversion application_changeset: ad086fddd66a309a119289f62fb782aa51bec15d 03:37:07 INFO - mozversion application_display_name: Nightly 03:37:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:37:07 INFO - mozversion application_name: Firefox 03:37:07 INFO - mozversion application_remotingname: firefox 03:37:07 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 03:37:07 INFO - mozversion application_vendor: Mozilla 03:37:07 INFO - mozversion application_version: 52.0a1 03:37:07 INFO - mozversion platform_buildid: 20161104022021 03:37:07 INFO - mozversion platform_changeset: ad086fddd66a309a119289f62fb782aa51bec15d 03:37:07 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 03:37:07 INFO - mozversion platform_version: 52.0a1 03:37:07 INFO - using testdate: 1478255827 03:37:07 INFO - actual date: 1478255827 03:37:07 INFO - starting webserver on 'localhost:42645' 03:37:07 INFO - SUITE-START | Running 2 tests 03:37:07 INFO - TEST-START | dromaeo_css 03:37:07 INFO - operating with platform_type : linux_ 03:37:07 INFO - Initialising browser for dromaeo_css test... 03:37:07 INFO - TEST-INFO | started process 12807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC3Fv0a/profile http://localhost:42645/getInfo.html) 03:37:11 INFO - PROCESS | 12807 | __metrics Screen width/height:1600/1200 03:37:11 INFO - PROCESS | 12807 | colorDepth:24 03:37:11 INFO - PROCESS | 12807 | Browser inner width/height: 1024/697 03:37:11 INFO - PROCESS | 12807 | __metrics 03:37:12 INFO - PROCESS | 12807 | 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" 03:37:12 INFO - PROCESS | 12807 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:37:12 INFO - PROCESS | 12807 | console.error: PushService: 03:37:12 INFO - PROCESS | 12807 | stateChangeProcessEnqueue: Error transitioning state 03:37:12 INFO - PROCESS | 12807 | UnknownError 03:37:13 INFO - TEST-INFO | 12807: exit 0 03:37:13 INFO - Browser initialized. 03:37:13 INFO - Running cycle 1/1 for dromaeo_css test... 03:37:13 INFO - TEST-INFO | started process 12887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC3Fv0a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:37:25 INFO - PROCESS | 12887 | RSS: Main: 174977024 03:37:25 INFO - PROCESS | 12887 | 03:38:17 INFO - PROCESS | 12887 | 1478255897402 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] 03:40:31 INFO - PROCESS | 12887 | Cycle 1(1): loaded http://localhost:42645/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42645/tests/dromaeo/cssquery-ext.html) 03:40:32 INFO - PROCESS | 12887 | RSS: Main: 306651136 03:40:32 INFO - PROCESS | 12887 | 03:43:35 INFO - PROCESS | 12887 | Cycle 1(1): loaded http://localhost:42645/tests/dromaeo/cssquery-ext.html (next: http://localhost:42645/tests/dromaeo/cssquery-jquery.html) 03:43:36 INFO - PROCESS | 12887 | RSS: Main: 278175744 03:43:36 INFO - PROCESS | 12887 | 03:46:38 INFO - PROCESS | 12887 | Cycle 1(1): loaded http://localhost:42645/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42645/tests/dromaeo/cssquery-mootools.html) 03:46:39 INFO - PROCESS | 12887 | RSS: Main: 222961664 03:46:39 INFO - PROCESS | 12887 | 03:49:41 INFO - PROCESS | 12887 | Cycle 1(1): loaded http://localhost:42645/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42645/tests/dromaeo/cssquery-prototype.html) 03:49:42 INFO - PROCESS | 12887 | RSS: Main: 221634560 03:49:42 INFO - PROCESS | 12887 | 03:52:45 INFO - PROCESS | 12887 | Cycle 1(1): loaded http://localhost:42645/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42645/tests/dromaeo/cssquery-yui.html) 03:52:45 INFO - PROCESS | 12887 | RSS: Main: 221392896 03:52:45 INFO - PROCESS | 12887 | 03:55:48 INFO - PROCESS | 12887 | Cycle 1(1): loaded http://localhost:42645/tests/dromaeo/cssquery-yui.html (next: http://localhost:42645/tests/dromaeo/cssquery-dojo.html) 03:55:49 INFO - PROCESS | 12887 | RSS: Main: 316821504 03:55:49 INFO - PROCESS | 12887 | 03:55:49 INFO - PROCESS | 12887 | __start_tp_report 03:55:49 INFO - PROCESS | 12887 | _x_x_mozilla_page_load 03:55:49 INFO - PROCESS | 12887 | _x_x_mozilla_page_load_details 03:55:49 INFO - PROCESS | 12887 | |i|pagename|runs| 03:55:49 INFO - PROCESS | 12887 | |0;dojo.html;2585.7931365490763;2590.727973562776;2623.6851577810667;2641.181233817517;2648.8410695358293;4586.908261834761;4613.261878099504;4674.3222232776225;4686.812527498901;4713.293006049094;4670.76646167692;4676.649251306158;4694.131585656647;4699.718016918987;4699.7415142167165;4284.271673815459;4307.935380969288;4314.180305741915;4337.609615134637;4412.75729834859;4387.341898715186;4398.4062151609605;4420.381146639473;4422.447194100738;4426.756528390937;4339.045410009809;4347.956520434786;4369.650427965755;4383.013821890081;4405.471343438792;4390.990072283361;4426.380306757057;4430.113977204572;4451.109778044388;4475.910481790346;4227.640650544708;4262.808173632163;4291.8068686908855;4339.349097635349;4346.56534346566;4722.929156062662;4723.385959825235;4730.314104454869;4734.857954261378;4811.49479304675;5034.144195486776;5083.8983220335385;5091.719955402451;5092.159793634046;5130.4356520782685;4940.580050695659;4984.651074424792;4987.351644286256;5114.335136432277;5162.716050617215;4703.247480403119;4718.363020992157;4719.150552900511;4719.5752382285755;4722;5118.61610379223;5288.92066619001;5290.127129023668;5293.8411847643865;5297.5232229099565;5005.874853128701;5007.574356179765;5009.7495125243595;5015.974920125376;5081.618878584121;5055.772490237948;5060.291559181717;5062.265971434122;5067.442581316052;5090.847274581768;4814.8796280093275;4900.26496025599;4901.068796928572;5023.824166154167;5060.316857224301;5010.3737032870895;5072.087024335655;5072.619553533426;5124.180131178993;5138.306328645585;4297.462817147856;4301.978490107592;4303.720258183208;4358.280883654225;4366.323219900921;3676.1361080146144;3692.2430901665093;3730.4404339349317;3741.363968125371;3796.620337966181;4375.474943006796;4395.978020109943;4401.2517871961845;4452;4452.888677783017;5069.1635880079375;5076.13705670037;5127.923081153711;5128;5165.48345165488;4239.872803815891;4261.998430368861;4337.392765012901;4351.0645211279725;4405.66957478184;4498.055408364215;4536.251518499476;4546.04533048057;4552.271636538138;4608.239640459286;4726.26742854858;4726.456457507362;4735.337052812678;4736.100140973204;4793.945332026949;4961.479044700399;5052.671576347526;5063.530347862757;5064.063148317573;5122.769475373691;4643.8374656886845;4645.140648979949;4683.648726345469;4692.178868698033;4762.452317983476;4884.3650325457465;4899.804007839646;4945.307656927961;4948.084604348207;4963.627727920492;5105.897882042264;5113.463086375877;5126.051680438982;5128.076946149728;5184.896302074013;4741.739204343657;4839.370881785346;4954.50454954516;4956.263891845315;4957.058158949788;4843.152448321459;4861.854144375674;4876.561109500162;4890.046440943982;4946.455889852042;4826.32431459603;4834.758262086812;4835.129676658235;4843.782029808596;4894.437139728977;4837.612990960644;4923.384576927884;4926.162552366035;4932.630052745986;4989.575886049726;4731.313959475926;4796.760161991956;4814.638902082428;4847.151748444078;4865.172920603577 03:55:49 INFO - PROCESS | 12887 | |1;ext.html;554.9778008879645;569.5614376929764;580.2659635561014;580.3036356372354;590.0146754919284;27895;37415;38881.22237555254;38881.80559097204;43189;39246.430142794256;39706;39707.60292397075;39713.801430992804;39721;7648.005759251303;7796;7800.492967957065;7800.609969501531;7803.648835802403;7718.536887786723;7804.414668899827;7808.5314881107315;7810.765677029698;7815.335696465807;7657.4639775215755;7746;7750.379969602446;7752.496087754278;7776.80557986052;7710.653020614086;7787.454878158531;7818.843623127505;7821.100573434071;7827.530348179127;7634.351080158138;7747.4964127332105;7749.418793590503;7750.612469376509;7751.961240193819;38415.61584384176;38450.23099538022;38477.42283865744;38806.417903731184;38842;3047.8171309721265;3090.6909309069138;3159.178613560468;3323.4350160472777;3447.3622379859808;28296.434071318665;28491.715082849114;29084.27289317763;29169.41661166786;29275.853620731974;3439.9312013759586;3450.1719587298867;3617.2584620152807;3655.3054919565197;3691.3171063353366;188853;190037;190325;190340;191420;30981.535276970862;50107;50420.24369634459;50512.74743626258;50570;33570.49644255338;33674.83162584171;33691.32617347688;33696.66303336984;33706;13319.06766526334;13534.729305414034;13537.864621353661;13544.796828047587;13550;11132.109431245643;11315.207935444605;11323.32060076398;11329.490172942073;11337.376444295478;7807.804804879924;7808.68765249395;7837.725679601187;7894.6842126314305;7895.644695988694;3100.767442441781;3127.280725433118;3130.917939570206;3151.401233765577;3187.9362412751616;858.978525536854;899.3974037394961;942.7313215733483;970.3401686853008;976.0727309056425;25828.096016639327;26832.32919177036;26873.462530749668;26982.32544186411;27161.86419067892;754.6679461037127;892.4645212872355;947.2422062350092;1000.9099181073739;1009;13234.205947643171;13876.167429954236;14296.285185740671;14306.713865722835;14338.856611433961;354298;355809;356027;356158;357043;49695.50304496909;50149;50200.246996295085;50221.24668129981;50245;1036.6009086501751;1111.0556027376665;1111.9388433636066;1189.4469071881617;1223.290491514937;26862;28759.712402875703;28873.711262887104;31266;32022.35955280928;46021.76989115033;46566.767166163954;46593.301100482844;46623.30065048959;46646.53353466422;314456;314729;314754;315795;316040;24989.375265618506;25251;30932.845335773178;31833.840830795696;38269.617303826606;39169.41245881371;39481.40777888276;43076.13847722965;43259;43922.78038609787;36895.815520922224;37020.629793701715;37094.36320459942;37138;37678;36464.635353646125;37189.44215836819;37484;37558.43662345012;37831;35984.64015359813;36470.4529432064;36884.262314754094;37174.628253717114;37620;32305.35389292154;34087.147821304665;34700.82649586736;35058.298834023684;35171.47242791309;25723.871380643726;26292.342691432103;26342.473150537266;26363.472730544898;26790.866045669645 03:55:49 INFO - PROCESS | 12887 | |2;jquery.html;338.7848716065298;359.3047453178099;365.3861512658733;368.59638695628286;386.06379529640617;12439.191452555577;13200.075994680376;15160.620984475394;16582.253798579062;16785.24466399012;15480.922595387008;15564;15777.763333549978;15876.920615396906;15903.12532810695;4884.902301953976;4891.951080489203;4990;5038.521340472649;5043.36957880265;3684.521012268401;3871.051592359862;5051.621128415383;5067.873303167414;5636.830895073133;5919.615225010382;6017.548683848707;6026;6026.8493287667725;6030.698465076751;5745.798897038625;5924.526037916957;5936.376680448534;6005.729742161591;6011.549133814981;5302.045631786277;5310.946890531122;5311.946880531223;5312.5218730314455;5312.601554883399;20026.1989520419;20394.388168354973;20684.58630827375;20831.687524687142;20955.5808883823;1926.2872737087368;2205.4817117977263;2261.0390584001734;2294.6443301288327;2559.808014398909;8822.779430514225;9419.623215071457;12506.874931250662;12917.612471625866;13696.383662735101;1587.5078725595104;1667.1830802906609;1701.5661006443402;1741.9564510887203;1753.6580366828473;57773;70947;73754.26245737527;74187.62906185488;74863.62568187233;9754.170895473964;9932.702018939442;10011.349262297927;10341.327813692085;10349.172066234683;13803.447862085404;13804.516841910485;13804.654883627989;13805.17168969865;13814.309284535733;7220.819479512949;7394.038774959221;7521;7574.091109066947;7626;7028.859422811515;7048.541844780176;7266.164391094986;7278.563286202845;7319.597422141834;4217.514985776614;4227.260229459894;4285.785710714452;4344.82620695175;4447.533009034005;1800.3878681248439;1802.3331367394148;1803.422904670493;1849.6948003579528;1874.878132921383;796.0884786919061;813.4265342933218;817.6320655704957;831.5303548461061;880.0935036911991;16653.250603722863;16858;16930.746038809426;17030.91484542594;17739.911300443415;831.3432388413207;834.2200042959852;845.5138295480124;855.2516548020482;902.0348227396622;9164.90835091654;9585.712428627152;9690.70927872165;9701.320907536547;9767.267454940766;343689;355411;366024;372055;374562;74380.62809686025;76263.61868190735;77685.6115719429;81796;86140;895.3821862914568;921.7326975177124;930.02812061396;932.47315266874;938.9108034736689;15549.922250388676;15621.453249136226;15895.443659471863;16214;16731;36315.27369452649;36724.44913326356;36975.44536831896;37096;39137.41293880537;50017.74991125167;51236;52695.20957185569;53640.195397068295;54730.726346368014;9123.452592844451;9809.95095024549;10033;10039.24705647094;10430.16558675289;10676.252662313564;10888.564457421615;10937.781244374908;10950.123990080934;11048.447577620926;6481.708323125376;6984.895226571504;9781.902180978099;9908;10007.799844002933;9659.565319560495;9823.26325525574;9848.507574621384;9893.65372211969;10111.443870587189;9650.758731031781;9872.654457093968;9980.900190997998;10169.03394177552;10331.483425828528;9622;9755.756106097404;9785.657501987396;9940.751481213027;10343.172546196136;7429.07136607924;7558.244175582618;9598.376105553116;9699.078587534173;9986.500674966077 03:55:49 INFO - PROCESS | 12887 | |3;mootools.html;1230.1389027680625;1343.3350491506703;1370.2669072046453;1435.260840667056;1658.8838781285315;5853.326867410249;6213.658248796314;6650.20197576291;6845.349691779285;6852.074969879065;6933.895991560131;6966.547174433658;6988.986596943453;6991.23096459389;7033.331833475811;2047.5802460495638;2078.2102800935622;2078.2310545098335;2078.6778049402365;2080.864743791649;2061.680439531875;2098.0244186453297;2099.1813192854797;2127.7978592033733;2134.4983928776724;2052.404802607242;2058.1561559760503;2074.6265672179;2076.9896150519226;2080.6358887194756;2029.3708950225403;2046.2735728816206;2046.9385918422472;2049.1905697249504;2049.5593447408805;2001.8898960557165;2018.2128969701828;2030.604032213719;2030.6344857925567;2032.7560692716968;6933.514653974224;6965.129358830146;7037.612931288777;7041;7048.506604537684;3982.7012974027066;4107.322291821846;4118.691098167649;4124.1133156371225;4124.8556300529635;2555.195113539229;2719.877605507757;2748.230495461274;2762.6408566886375;2766.1978026372326;874.5670892907988;884.3367474394204;889.4663202078701;1708.2227586448137;1749.8337657922477;8825.02924678285;8835.911640883638;8897.777555561099;8919.509426981513;8933.731988040368;3554.298732962967;3593.6765691087926;3599.2441587266444;3653.1232504199334;3681.042928838521;7234.312740289664;7292.489525733148;7301.342879140902;7307.378872795765;7346;4107.589241075928;4113;4119.546849846514;4143.875683729493;4145.336746120606;3326.6340702522702;3441.2773317603583;3644.927101457956;3745.419459983707;3783.9621603784162;2995.176326510227;3048.8018278811805;3093.7215650591106;3139.073973177918;3161.9683803162134;949.6676163342775;953.1659797677032;953.3612479638658;961.927855410847;964.9807003860024;796.4424902568226;816.3628807219602;844.759243615579;851.5954921412404;853.1127627267696;4597.747123908217;4604.930926036112;4629.745364005012;4716.3632909557455;4852.44196917359;368.7252996517558;375.6093662590875;377.60540235454016;384.5404741334079;388.3630845413524;3161.8893338733033;3269.5095735639843;3275.5086736989642;3295.4562497187694;3344.9331013379597;7572.924270757332;7702.845943081107;7940.880886786703;8002.51984880909;8041.718539851077;8116.715914943066;8125.228103330174;8135.064467586303;8136.633851476698;8137.959310203411;6301.936980630135;6340.619562826245;6356.110144579762;6361.9045714314325;6551.967240163769;4766.594839438687;4774.1883879739835;4809.0905002473;4907.460179380194;5002.899942001212;7676.117246516722;7682.116556596063;7719.884201736866;7778.416618753503;7780.1052878919645;7287.307705767944;7557.584332861746;7559.092908850753;7565.962170189114;7708.267714567107;6032.125341825498;6172.074188871526;6173.104899789416;6182.165407669907;6184.072389141485;5853.94146058534;5990.910136348046;6407.327230640715;6462.192225971754;6472.255690595642;5904.763809447574;5955.315138759098;6045.879082418415;6087.57386982907;6142;5922.73347699346;5978.790742323998;6032.909506357496;6042.123892035543;6059.454649081604;5441.918371224514;5548.528375088163;5577.888442231214;5630.18362337467;5729.799457018984;4098.754074755524;4117.505899292104;4190.580941905785;4220.493540775126;4308.2460569400855;4074.6536544394057;4089.488813898263;4138.5654506276405;4175.665946724315;4213.325867861127 03:55:49 INFO - PROCESS | 12887 | |4;prototype.html;283.98296102233866;284.2368241272184;287.9064304101167;291.7797063217271;293.1425580177979;4798.088363210992;4816.807327706896;4839.4192696876335;4843.951560484394;4844.418669759634;4712.481627021033;4764.332993380929;4764.809407623699;4767.499412561683;4780.16347139251;3512.2624248907696;3613.7831730096145;3639.290338384016;3702.629737026303;3730.899384681512;3733.136204028831;3742.101895545077;3748.6063963283873;3764.5106136202257;3765.585785563586;3713.4429835524616;3728.5152930119048;3730.7201959852982;3731.3097077040834;3757.849686012556;3532.876349327774;3617.186133120027;3657.963420365802;3673.2102597941303;3725.18046029873;3280.4095262852675;3283.1627934876456;3288.3752087103376;3289.588801399825;3295.110320213529;4672.761718144694;4684.407301517466;4687.343771871941;4701.388819453483;4707.764611769432;4169.687273454503;4191.862150303336;4251.681123915719;4260.744355338689;4270.829166833323;4960.776765045582;4964.677295975786;4970.950290497085;4973.378327709036;5014.147594908874;3589.300086483137;3590.9461358079648;3592.4552442449735;3600.279944011208;3611.56661200655;4898.338724272249;5209.218617207412;5218.504242096995;5231.843044708665;5250.474952504757;3530.5763308402643;3547.4856145858707;3553.680168784822;3575.1955809942556;3577.7853328800356;3584.6594573515476;3603.819809009539;3624.2751449709635;3650.3976843821;3656.634336566375;4166.1251137261515;4166.8749937501925;4203.528764932249;4204.3693445983345;4204.495460544754;4856.902861942742;4985.850424487271;4991.80032798684;5086.949130508721;5090.847274581768;1234.333459931627;1239.4112796421807;1240.9193402428814;1242.571312897049;1244.2223610243598;763.3320844261272;772.5557804262571;785.5012067337168;803.5656353409137;813.4834380168636;4293.175400454794;4305.913881722348;4434.5343738907595;4449.421575195269;4468.821247150143;5121.667091639031;5150.8969820604125;5163.845084647466;5174.7153906535505;5207.062728708869;4478.373027776114;4482.843100491467;4488.640908727294;4500.909981800346;4502.842400515966;2596.0524408591104;2742.3966727319957;2746.763956219709;2756.8483733394855;2766.2531116598807;4883.194272944996;4888.902221955541;4889.731064791399;4896.804127834918;4897.338859254026;5046.34397528319;5261.579073674096;5282.207668849626;5288.65623734456;5295;4870.732109733999;4897.14299997499;4902.7988142904505;4942.752862356868;4944.505549445027;5152.510511501401;5229.973850130725;5232.424433312409;5234.712090835041;5238.711870846988;4914.36113305268;5117.641765076409;5125.589952803842;5131.897362052813;5143.6399452037995;4898.951010489849;4904.043711476371;4908.9754551227015;4911.4106307243355;4921.655484116078;3547.3614749345365;3563.590187128513;3568.3576956148145;3573.857045718142;3584.462330650423;4943.467525067241;5216.452272511332;5223.634345595924;5235.136202526541;5242.816501422432;5029.597632189343;5032.7483625819295;5050.949490505195;5053.393592768891;5058.898822023612;5000.699958002531;5014.84955451337;5029.924551131663;5034.345535080416;5036.345275114211;4798.49615790337;4952;4955.529224723646;4964.081644895706;4969.925451118163;4838.032393521239;4898.755062246944;4952.232403977389;5015.219597043143;5053.31780209667;4875.658703890694;4934.5805606523845;4953.826616068421;4964.478729733326;4976.850694479172 03:55:49 INFO - PROCESS | 12887 | |5;yui.html;624.2508989212946;630.9999999999999;652.4226059936955;674.9358810912962;720.2977097330103;12297.877021229786;12384.93807530961;12986.74026519469;13005.479780808768;13011.934940325309;14355.138691678507;14545.490907818228;14591.34338954747;14591.635209119777;14597.78103328451;625.7371903800392;639.9264084630281;787.1813314153273;810.205998121838;814.242754238558;773.5010917957914;790.3716545346434;797.0594698256056;801.8115742800437;802.8394321135767;809.3808236698901;810.3274282345639;810.3800592546677;810.8540462716709;811.0389188811248;647.5499527828161;665.4310564467407;805.963731632078;806.6853926968516;807.4186585658375;593.967331796751;609.2536642612808;611.6024584020378;614.008376471999;614.732591322776;13051.412686429134;13054.934725326408;13064.608061758163;13073.803892941518;13138.86861131386;11726.882731172664;11889.583864564698;12143.149979501439;12275.38623068843;12377;10666.306690065121;10769.246152769309;11108.389038602874;11214.775704485864;11613.419329033515;3979.98010009951;4003.199360127957;4032.4556184914954;4055.3916912463364;4110.712250142491;51319.230211546484;51515.22727159096;52166.47833521654;52625.7368713154;52865.735671321396;9579.233661307078;9832.950835245778;9875.901240987498;9884;9993.300468967103;17246.655066898842;17248.396306129227;17257.223424945907;17347.82652173462;17468.213930373164;6242.781502647385;6484.675766211671;6495.772647957393;6510.869782604322;6700.865982680319;3591.2996965591983;3632.20091579852;3673.7979411132646;3780.0549862534367;3847.576766555733;2697.9595306070423;2759.089500464842;2776.5002299586267;2783.234610482093;2786.414852880918;476.2499063974185;482.4524165072668;488.482208858611;491.6632107006712;492.4017318957484;516.8811173430132;539.7840863654569;540.2571464236675;572.6249306704116;585.3210276079727;7464.216257293015;7469.701211951569;7603.467757256939;7724.459287849797;8215.753527394188;461.9491855895849;502.52762403340745;515.4896652314256;563.144021087944;585.8418227078665;3630.8366123524506;3649.1948546452204;3761.9059523511582;3817.5037245158505;3888.0862997195636;68557;69643.65178174178;71560.2843971564;71592.64203678949;73847;40933.38599921003;41827.58172418237;61841;65358.34641653618;66649.33350666432;57941.710291448275;58364.1635836413;58710.41289587135;58773.706131469065;59155.70422147862;7000.754973576104;7266.273372662691;7410.9258907412395;7441.293077157661;7616.619169041636;37833.432498513095;39291.21417571575;39625.40561891632;39640.80179599083;39955;48947;49328;53306.20040699315;54782.17826732682;55167.207443217885;9393.107654772786;9467.431954082776;9632.807343852943;9663.178629816544;9979.950100249453;10649.627263045757;10734.785304294026;10809.189310801565;10928.945355273172;11119.499622516845;9946.751331216778;9954.502274886081;10177.592896284363;10366.06705396518;10534.157267418741;10315.587376504856;10385.428801415994;10441.68674939753;10495.21285903545;10554.261201715806;9765.60937562518;9766;9821.214302855897;9869;9927.801443971224;8154.504295391137;8424.157584241526;8498.107698691549;8760.4305720128;8831.116888311117;8023.83952320962;8611.526366049928;8694.695685650971;8716.477011379338;8729.91270087291 03:55:49 INFO - PROCESS | 12887 | __end_tp_report 03:55:49 INFO - PROCESS | 12887 | __start_cc_report 03:55:49 INFO - PROCESS | 12887 | _x_x_mozilla_cycle_collect,1285 03:55:49 INFO - PROCESS | 12887 | __end_cc_report 03:55:49 INFO - PROCESS | 12887 | __startTimestamp1478256949223__endTimestamp 03:55:49 INFO - PROCESS | 12887 | 03:55:49 INFO - PROCESS | 12887 | ------- Summary: start ------- 03:55:49 INFO - PROCESS | 12887 | Number of tests: 6 03:55:49 INFO - PROCESS | 12887 | 03:55:49 INFO - PROCESS | 12887 | [#0] dojo.html Cycles:165 Average:4669.81 Median:4736.10 stddev:493.29 (10.4%) stddev-sans-first:466.92 03:55:49 INFO - PROCESS | 12887 | Values: 2585.8 2590.7 2623.7 2641.2 2648.8 4586.9 4613.3 4674.3 4686.8 4713.3 4670.8 4676.6 4694.1 4699.7 4699.7 4284.3 4307.9 4314.2 4337.6 4412.8 4387.3 4398.4 4420.4 4422.4 4426.8 4339.0 4348.0 4369.7 4383.0 4405.5 4391.0 4426.4 4430.1 4451.1 4475.9 4227.6 4262.8 4291.8 4339.3 4346.6 4722.9 4723.4 4730.3 4734.9 4811.5 5034.1 5083.9 5091.7 5092.2 5130.4 4940.6 4984.7 4987.4 5114.3 5162.7 4703.2 4718.4 4719.2 4719.6 4722.0 5118.6 5288.9 5290.1 5293.8 5297.5 5005.9 5007.6 5009.7 5016.0 5081.6 5055.8 5060.3 5062.3 5067.4 5090.8 4814.9 4900.3 4901.1 5023.8 5060.3 5010.4 5072.1 5072.6 5124.2 5138.3 4297.5 4302.0 4303.7 4358.3 4366.3 3676.1 3692.2 3730.4 3741.4 3796.6 4375.5 4396.0 4401.3 4452.0 4452.9 5069.2 5076.1 5127.9 5128.0 5165.5 4239.9 4262.0 4337.4 4351.1 4405.7 4498.1 4536.3 4546.0 4552.3 4608.2 4726.3 4726.5 4735.3 4736.1 4793.9 4961.5 5052.7 5063.5 5064.1 5122.8 4643.8 4645.1 4683.6 4692.2 4762.5 4884.4 4899.8 4945.3 4948.1 4963.6 5105.9 5113.5 5126.1 5128.1 5184.9 4741.7 4839.4 4954.5 4956.3 4957.1 4843.2 4861.9 4876.6 4890.0 4946.5 4826.3 4834.8 4835.1 4843.8 4894.4 4837.6 4923.4 4926.2 4932.6 4989.6 4731.3 4796.8 4814.6 4847.2 4865.2 03:55:49 INFO - PROCESS | 12887 | 03:55:49 INFO - PROCESS | 12887 | [#1] ext.html Cycles:180 Average:43929.70 Median:36890.04 stddev:77888.64 (211.1%) stddev-sans-first:78039.05 03:55:49 INFO - PROCESS | 12887 | Values: 555.0 569.6 580.3 580.3 590.0 27895.0 37415.0 38881.2 38881.8 43189.0 39246.4 39706.0 39707.6 39713.8 39721.0 7648.0 7796.0 7800.5 7800.6 7803.6 7718.5 7804.4 7808.5 7810.8 7815.3 7657.5 7746.0 7750.4 7752.5 7776.8 7710.7 7787.5 7818.8 7821.1 7827.5 7634.4 7747.5 7749.4 7750.6 7752.0 38415.6 38450.2 38477.4 38806.4 38842.0 3047.8 3090.7 3159.2 3323.4 3447.4 28296.4 28491.7 29084.3 29169.4 29275.9 3439.9 3450.2 3617.3 3655.3 3691.3 188853.0 190037.0 190325.0 190340.0 191420.0 30981.5 50107.0 50420.2 50512.7 50570.0 33570.5 33674.8 33691.3 33696.7 33706.0 13319.1 13534.7 13537.9 13544.8 13550.0 11132.1 11315.2 11323.3 11329.5 11337.4 7807.8 7808.7 7837.7 7894.7 7895.6 3100.8 3127.3 3130.9 3151.4 3187.9 859.0 899.4 942.7 970.3 976.1 25828.1 26832.3 26873.5 26982.3 27161.9 754.7 892.5 947.2 1000.9 1009.0 13234.2 13876.2 14296.3 14306.7 14338.9 354298.0 355809.0 356027.0 356158.0 357043.0 49695.5 50149.0 50200.2 50221.2 50245.0 1036.6 1111.1 1111.9 1189.4 1223.3 26862.0 28759.7 28873.7 31266.0 32022.4 46021.8 46566.8 46593.3 46623.3 46646.5 314456.0 314729.0 314754.0 315795.0 316040.0 24989.4 25251.0 30932.8 31833.8 38269.6 39169.4 39481.4 43076.1 43259.0 43922.8 36895.8 37020.6 37094.4 37138.0 37678.0 36464.6 37189.4 37484.0 37558.4 37831.0 35984.6 36470.5 36884.3 37174.6 37620.0 32305.4 34087.1 34700.8 35058.3 35171.5 25723.9 26292.3 26342.5 26363.5 26790.9 03:55:49 INFO - PROCESS | 12887 | 03:55:49 INFO - PROCESS | 12887 | [#2] jquery.html Cycles:180 Average:23703.74 Median:5040.95 stddev:60153.72 (1193.3%) stddev-sans-first:60296.88 03:55:49 INFO - PROCESS | 12887 | Values: 338.8 359.3 365.4 368.6 386.1 12439.2 13200.1 15160.6 16582.3 16785.2 15480.9 15564.0 15777.8 15876.9 15903.1 4884.9 4892.0 4990.0 5038.5 5043.4 3684.5 3871.1 5051.6 5067.9 5636.8 5919.6 6017.5 6026.0 6026.8 6030.7 5745.8 5924.5 5936.4 6005.7 6011.5 5302.0 5310.9 5311.9 5312.5 5312.6 20026.2 20394.4 20684.6 20831.7 20955.6 1926.3 2205.5 2261.0 2294.6 2559.8 8822.8 9419.6 12506.9 12917.6 13696.4 1587.5 1667.2 1701.6 1742.0 1753.7 57773.0 70947.0 73754.3 74187.6 74863.6 9754.2 9932.7 10011.3 10341.3 10349.2 13803.4 13804.5 13804.7 13805.2 13814.3 7220.8 7394.0 7521.0 7574.1 7626.0 7028.9 7048.5 7266.2 7278.6 7319.6 4217.5 4227.3 4285.8 4344.8 4447.5 1800.4 1802.3 1803.4 1849.7 1874.9 796.1 813.4 817.6 831.5 880.1 16653.3 16858.0 16930.7 17030.9 17739.9 831.3 834.2 845.5 855.3 902.0 9164.9 9585.7 9690.7 9701.3 9767.3 343689.0 355411.0 366024.0 372055.0 374562.0 74380.6 76263.6 77685.6 81796.0 86140.0 895.4 921.7 930.0 932.5 938.9 15549.9 15621.5 15895.4 16214.0 16731.0 36315.3 36724.4 36975.4 37096.0 39137.4 50017.7 51236.0 52695.2 53640.2 54730.7 9123.5 9810.0 10033.0 10039.2 10430.2 10676.3 10888.6 10937.8 10950.1 11048.4 6481.7 6984.9 9781.9 9908.0 10007.8 9659.6 9823.3 9848.5 9893.7 10111.4 9650.8 9872.7 9980.9 10169.0 10331.5 9622.0 9755.8 9785.7 9940.8 10343.2 7429.1 7558.2 9598.4 9699.1 9986.5 03:55:49 INFO - PROCESS | 12887 | 03:55:49 INFO - PROCESS | 12887 | [#3] mootools.html Cycles:180 Average:4492.79 Median:4955.18 stddev:2393.63 (48.3%) stddev-sans-first:2387.78 03:55:49 INFO - PROCESS | 12887 | Values: 1230.1 1343.3 1370.3 1435.3 1658.9 5853.3 6213.7 6650.2 6845.3 6852.1 6933.9 6966.5 6989.0 6991.2 7033.3 2047.6 2078.2 2078.2 2078.7 2080.9 2061.7 2098.0 2099.2 2127.8 2134.5 2052.4 2058.2 2074.6 2077.0 2080.6 2029.4 2046.3 2046.9 2049.2 2049.6 2001.9 2018.2 2030.6 2030.6 2032.8 6933.5 6965.1 7037.6 7041.0 7048.5 3982.7 4107.3 4118.7 4124.1 4124.9 2555.2 2719.9 2748.2 2762.6 2766.2 874.6 884.3 889.5 1708.2 1749.8 8825.0 8835.9 8897.8 8919.5 8933.7 3554.3 3593.7 3599.2 3653.1 3681.0 7234.3 7292.5 7301.3 7307.4 7346.0 4107.6 4113.0 4119.5 4143.9 4145.3 3326.6 3441.3 3644.9 3745.4 3784.0 2995.2 3048.8 3093.7 3139.1 3162.0 949.7 953.2 953.4 961.9 965.0 796.4 816.4 844.8 851.6 853.1 4597.7 4604.9 4629.7 4716.4 4852.4 368.7 375.6 377.6 384.5 388.4 3161.9 3269.5 3275.5 3295.5 3344.9 7572.9 7702.8 7940.9 8002.5 8041.7 8116.7 8125.2 8135.1 8136.6 8138.0 6301.9 6340.6 6356.1 6361.9 6552.0 4766.6 4774.2 4809.1 4907.5 5002.9 7676.1 7682.1 7719.9 7778.4 7780.1 7287.3 7557.6 7559.1 7566.0 7708.3 6032.1 6172.1 6173.1 6182.2 6184.1 5853.9 5990.9 6407.3 6462.2 6472.3 5904.8 5955.3 6045.9 6087.6 6142.0 5922.7 5978.8 6032.9 6042.1 6059.5 5441.9 5548.5 5577.9 5630.2 5729.8 4098.8 4117.5 4190.6 4220.5 4308.2 4074.7 4089.5 4138.6 4175.7 4213.3 03:55:49 INFO - PROCESS | 12887 | 03:55:49 INFO - PROCESS | 12887 | [#4] prototype.html Cycles:180 Average:4156.32 Median:4798.29 stddev:1226.29 (25.6%) stddev-sans-first:1194.79 03:55:49 INFO - PROCESS | 12887 | Values: 284.0 284.2 287.9 291.8 293.1 4798.1 4816.8 4839.4 4844.0 4844.4 4712.5 4764.3 4764.8 4767.5 4780.2 3512.3 3613.8 3639.3 3702.6 3730.9 3733.1 3742.1 3748.6 3764.5 3765.6 3713.4 3728.5 3730.7 3731.3 3757.8 3532.9 3617.2 3658.0 3673.2 3725.2 3280.4 3283.2 3288.4 3289.6 3295.1 4672.8 4684.4 4687.3 4701.4 4707.8 4169.7 4191.9 4251.7 4260.7 4270.8 4960.8 4964.7 4971.0 4973.4 5014.1 3589.3 3590.9 3592.5 3600.3 3611.6 4898.3 5209.2 5218.5 5231.8 5250.5 3530.6 3547.5 3553.7 3575.2 3577.8 3584.7 3603.8 3624.3 3650.4 3656.6 4166.1 4166.9 4203.5 4204.4 4204.5 4856.9 4985.9 4991.8 5086.9 5090.8 1234.3 1239.4 1240.9 1242.6 1244.2 763.3 772.6 785.5 803.6 813.5 4293.2 4305.9 4434.5 4449.4 4468.8 5121.7 5150.9 5163.8 5174.7 5207.1 4478.4 4482.8 4488.6 4500.9 4502.8 2596.1 2742.4 2746.8 2756.8 2766.3 4883.2 4888.9 4889.7 4896.8 4897.3 5046.3 5261.6 5282.2 5288.7 5295.0 4870.7 4897.1 4902.8 4942.8 4944.5 5152.5 5230.0 5232.4 5234.7 5238.7 4914.4 5117.6 5125.6 5131.9 5143.6 4899.0 4904.0 4909.0 4911.4 4921.7 3547.4 3563.6 3568.4 3573.9 3584.5 4943.5 5216.5 5223.6 5235.1 5242.8 5029.6 5032.7 5050.9 5053.4 5058.9 5000.7 5014.8 5029.9 5034.3 5036.3 4798.5 4952.0 4955.5 4964.1 4969.9 4838.0 4898.8 4952.2 5015.2 5053.3 4875.7 4934.6 4953.8 4964.5 4976.9 03:55:49 INFO - PROCESS | 12887 | 03:55:49 INFO - PROCESS | 12887 | [#5] yui.html Cycles:180 Average:14694.63 Median:27865.18 stddev:19048.25 (68.4%) stddev-sans-first:19072.38 03:55:49 INFO - PROCESS | 12887 | Values: 624.3 631.0 652.4 674.9 720.3 12297.9 12384.9 12986.7 13005.5 13011.9 14355.1 14545.5 14591.3 14591.6 14597.8 625.7 639.9 787.2 810.2 814.2 773.5 790.4 797.1 801.8 802.8 809.4 810.3 810.4 810.9 811.0 647.5 665.4 806.0 806.7 807.4 594.0 609.3 611.6 614.0 614.7 13051.4 13054.9 13064.6 13073.8 13138.9 11726.9 11889.6 12143.1 12275.4 12377.0 10666.3 10769.2 11108.4 11214.8 11613.4 3980.0 4003.2 4032.5 4055.4 4110.7 51319.2 51515.2 52166.5 52625.7 52865.7 9579.2 9833.0 9875.9 9884.0 9993.3 17246.7 17248.4 17257.2 17347.8 17468.2 6242.8 6484.7 6495.8 6510.9 6700.9 3591.3 3632.2 3673.8 3780.1 3847.6 2698.0 2759.1 2776.5 2783.2 2786.4 476.2 482.5 488.5 491.7 492.4 516.9 539.8 540.3 572.6 585.3 7464.2 7469.7 7603.5 7724.5 8215.8 461.9 502.5 515.5 563.1 585.8 3630.8 3649.2 3761.9 3817.5 3888.1 68557.0 69643.7 71560.3 71592.6 73847.0 40933.4 41827.6 61841.0 65358.3 66649.3 57941.7 58364.2 58710.4 58773.7 59155.7 7000.8 7266.3 7410.9 7441.3 7616.6 37833.4 39291.2 39625.4 39640.8 39955.0 48947.0 49328.0 53306.2 54782.2 55167.2 9393.1 9467.4 9632.8 9663.2 9980.0 10649.6 10734.8 10809.2 10928.9 11119.5 9946.8 9954.5 10177.6 10366.1 10534.2 10315.6 10385.4 10441.7 10495.2 10554.3 9765.6 9766.0 9821.2 9869.0 9927.8 8154.5 8424.2 8498.1 8760.4 8831.1 8023.8 8611.5 8694.7 8716.5 8729.9 03:55:49 INFO - PROCESS | 12887 | -------- Summary: end -------- 03:55:49 INFO - PROCESS | 12887 | 03:55:50 INFO - TEST-INFO | 12887: exit 0 03:55:50 INFO - TEST-OK | dromaeo_css | took 1123194ms 03:55:50 INFO - TEST-START | kraken 03:55:50 INFO - operating with platform_type : linux_ 03:55:50 INFO - Initialising browser for kraken test... 03:55:50 INFO - TEST-INFO | started process 13193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRzW2Gl/profile http://localhost:42645/getInfo.html) 03:55:54 INFO - PROCESS | 13193 | __metrics Screen width/height:1600/1200 03:55:54 INFO - PROCESS | 13193 | colorDepth:24 03:55:54 INFO - PROCESS | 13193 | Browser inner width/height: 1024/697 03:55:54 INFO - PROCESS | 13193 | __metrics 03:55:55 INFO - PROCESS | 13193 | 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" 03:55:55 INFO - PROCESS | 13193 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:55:55 INFO - PROCESS | 13193 | console.error: PushService: 03:55:55 INFO - PROCESS | 13193 | stateChangeProcessEnqueue: Error transitioning state 03:55:55 INFO - PROCESS | 13193 | UnknownError 03:55:56 INFO - TEST-INFO | 13193: exit 0 03:55:56 INFO - Browser initialized. 03:55:56 INFO - Running cycle 1/1 for kraken test... 03:55:56 INFO - TEST-INFO | started process 13273 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRzW2Gl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:08 INFO - PROCESS | 13273 | RSS: Main: 175005696 03:56:08 INFO - PROCESS | 13273 | 03:56:11 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:42645/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42645/tests/kraken/driver.html?testName=audio-beat-detection) 03:56:12 INFO - PROCESS | 13273 | RSS: Main: 229953536 03:56:12 INFO - PROCESS | 13273 | 03:56:15 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:42645/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42645/tests/kraken/driver.html?testName=audio-dft) 03:56:15 INFO - PROCESS | 13273 | RSS: Main: 218718208 03:56:15 INFO - PROCESS | 13273 | 03:56:19 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:42645/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42645/tests/kraken/driver.html?testName=audio-fft) 03:56:19 INFO - PROCESS | 13273 | RSS: Main: 299982848 03:56:19 INFO - PROCESS | 13273 | 03:56:21 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:42645/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42645/tests/kraken/driver.html?testName=audio-oscillator) 03:56:22 INFO - PROCESS | 13273 | RSS: Main: 208920576 03:56:22 INFO - PROCESS | 13273 | 03:56:24 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:42645/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42645/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:56:25 INFO - PROCESS | 13273 | RSS: Main: 213823488 03:56:25 INFO - PROCESS | 13273 | 03:56:28 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:42645/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42645/tests/kraken/driver.html?testName=imaging-darkroom) 03:56:29 INFO - PROCESS | 13273 | RSS: Main: 249208832 03:56:29 INFO - PROCESS | 13273 | 03:56:32 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:42645/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42645/tests/kraken/driver.html?testName=imaging-desaturate) 03:56:33 INFO - PROCESS | 13273 | RSS: Main: 243630080 03:56:33 INFO - PROCESS | 13273 | 03:56:35 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:42645/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42645/tests/kraken/driver.html?testName=json-parse-financial) 03:56:36 INFO - PROCESS | 13273 | RSS: Main: 245829632 03:56:36 INFO - PROCESS | 13273 | 03:56:38 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:42645/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42645/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:56:38 INFO - PROCESS | 13273 | RSS: Main: 209539072 03:56:38 INFO - PROCESS | 13273 | 03:56:40 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:42645/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42645/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:56:41 INFO - PROCESS | 13273 | RSS: Main: 216920064 03:56:41 INFO - PROCESS | 13273 | 03:56:43 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:42645/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42645/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:56:44 INFO - PROCESS | 13273 | RSS: Main: 225427456 03:56:44 INFO - PROCESS | 13273 | 03:56:46 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:42645/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42645/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:56:47 INFO - PROCESS | 13273 | RSS: Main: 234033152 03:56:47 INFO - PROCESS | 13273 | 03:56:50 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:42645/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42645/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:56:51 INFO - PROCESS | 13273 | RSS: Main: 231510016 03:56:51 INFO - PROCESS | 13273 | 03:56:53 INFO - PROCESS | 13273 | Cycle 1(1): loaded http://localhost:42645/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42645/tests/kraken/driver.html?testName=ai-astar) 03:56:53 INFO - PROCESS | 13273 | RSS: Main: 282812416 03:56:53 INFO - PROCESS | 13273 | 03:56:53 INFO - PROCESS | 13273 | __start_tp_report 03:56:53 INFO - PROCESS | 13273 | _x_x_mozilla_page_load 03:56:53 INFO - PROCESS | 13273 | _x_x_mozilla_page_load_details 03:56:53 INFO - PROCESS | 13273 | |i|pagename|runs| 03:56:53 INFO - PROCESS | 13273 | |0;ai-astar;109;117;118;116;116;118;116;117;116;118 03:56:53 INFO - PROCESS | 13273 | |1;audio-beat-detection;162;132;131;185;128;131;130;144;168;130 03:56:53 INFO - PROCESS | 13273 | |2;audio-dft;161;161;160;161;161;160;162;162;160;160 03:56:53 INFO - PROCESS | 13273 | |3;audio-fft;75;77;77;106;78;79;86;78;99;77 03:56:53 INFO - PROCESS | 13273 | |4;audio-oscillator;84;84;120;83;83;83;104;83;85;119 03:56:53 INFO - PROCESS | 13273 | |5;imaging-gaussian-blur;117;117;117;116;117;116;118;117;117;117 03:56:53 INFO - PROCESS | 13273 | |6;imaging-darkroom;146;148;146;146;147;149;147;146;146;148 03:56:53 INFO - PROCESS | 13273 | |7;imaging-desaturate;84;85;85;84;85;85;85;85;84;84 03:56:53 INFO - PROCESS | 13273 | |8;json-parse-financial;62;62;62;64;63;63;63;63;64;63 03:56:53 INFO - PROCESS | 13273 | |9;json-stringify-tinderbox;66;67;67;66;66;67;69;67;66;67 03:56:53 INFO - PROCESS | 13273 | |10;stanford-crypto-aes;85;92;85;87;90;84;85;83;84;84 03:56:53 INFO - PROCESS | 13273 | |11;stanford-crypto-ccm;141;143;143;153;142;143;144;151;187;141 03:56:53 INFO - PROCESS | 13273 | |12;stanford-crypto-pbkdf2;184;181;179;181;187;186;186;181;184;181 03:56:53 INFO - PROCESS | 13273 | |13;stanford-crypto-sha256-iterative;70;70;73;70;70;70;73;71;70;70 03:56:53 INFO - PROCESS | 13273 | __end_tp_report 03:56:53 INFO - PROCESS | 13273 | __start_cc_report 03:56:53 INFO - PROCESS | 13273 | _x_x_mozilla_cycle_collect,1923 03:56:53 INFO - PROCESS | 13273 | __end_cc_report 03:56:53 INFO - PROCESS | 13273 | __startTimestamp1478257013369__endTimestamp 03:56:53 INFO - PROCESS | 13273 | 03:56:53 INFO - PROCESS | 13273 | ------- Summary: start ------- 03:56:53 INFO - PROCESS | 13273 | Number of tests: 14 03:56:53 INFO - PROCESS | 13273 | 03:56:53 INFO - PROCESS | 13273 | [#0] ai-astar Cycles:10 Average:116.10 Median:117.00 stddev:2.64 (2.3%) stddev-sans-first:0.93 03:56:53 INFO - PROCESS | 13273 | Values: 109.0 117.0 118.0 116.0 116.0 118.0 116.0 117.0 116.0 118.0 03:56:53 INFO - PROCESS | 13273 | 03:56:53 INFO - PROCESS | 13273 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:138.00 stddev:20.31 (14.7%) stddev-sans-first:20.48 03:56:53 INFO - PROCESS | 13273 | Values: 162.0 132.0 131.0 185.0 128.0 131.0 130.0 144.0 168.0 130.0 03:56:53 INFO - PROCESS | 13273 | 03:56:53 INFO - PROCESS | 13273 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 03:56:53 INFO - PROCESS | 13273 | Values: 161.0 161.0 160.0 161.0 161.0 160.0 162.0 162.0 160.0 160.0 03:56:53 INFO - PROCESS | 13273 | 03:56:53 INFO - PROCESS | 13273 | [#3] audio-fft Cycles:10 Average:83.20 Median:78.00 stddev:10.71 (13.7%) stddev-sans-first:10.94 03:56:53 INFO - PROCESS | 13273 | Values: 75.0 77.0 77.0 106.0 78.0 79.0 86.0 78.0 99.0 77.0 03:56:53 INFO - PROCESS | 13273 | 03:56:53 INFO - PROCESS | 13273 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:83.00 stddev:15.46 (18.6%) stddev-sans-first:16.07 03:56:53 INFO - PROCESS | 13273 | Values: 84.0 84.0 120.0 83.0 83.0 83.0 104.0 83.0 85.0 119.0 03:56:53 INFO - PROCESS | 13273 | 03:56:53 INFO - PROCESS | 13273 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 03:56:53 INFO - PROCESS | 13273 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 118.0 117.0 117.0 117.0 03:56:53 INFO - PROCESS | 13273 | 03:56:53 INFO - PROCESS | 13273 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 03:56:53 INFO - PROCESS | 13273 | Values: 146.0 148.0 146.0 146.0 147.0 149.0 147.0 146.0 146.0 148.0 03:56:53 INFO - PROCESS | 13273 | 03:56:53 INFO - PROCESS | 13273 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.50 03:56:53 INFO - PROCESS | 13273 | Values: 84.0 85.0 85.0 84.0 85.0 85.0 85.0 85.0 84.0 84.0 03:56:53 INFO - PROCESS | 13273 | 03:56:53 INFO - PROCESS | 13273 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 03:56:53 INFO - PROCESS | 13273 | Values: 62.0 62.0 62.0 64.0 63.0 63.0 63.0 63.0 64.0 63.0 03:56:53 INFO - PROCESS | 13273 | 03:56:53 INFO - PROCESS | 13273 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 03:56:53 INFO - PROCESS | 13273 | Values: 66.0 67.0 67.0 66.0 66.0 67.0 69.0 67.0 66.0 67.0 03:56:53 INFO - PROCESS | 13273 | 03:56:53 INFO - PROCESS | 13273 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.00 stddev:2.92 (3.4%) stddev-sans-first:3.08 03:56:53 INFO - PROCESS | 13273 | Values: 85.0 92.0 85.0 87.0 90.0 84.0 85.0 83.0 84.0 84.0 03:56:53 INFO - PROCESS | 13273 | 03:56:53 INFO - PROCESS | 13273 | [#11] stanford-crypto-ccm Cycles:10 Average:148.80 Median:143.50 stddev:14.04 (9.8%) stddev-sans-first:14.60 03:56:53 INFO - PROCESS | 13273 | Values: 141.0 143.0 143.0 153.0 142.0 143.0 144.0 151.0 187.0 141.0 03:56:53 INFO - PROCESS | 13273 | 03:56:53 INFO - PROCESS | 13273 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.00 Median:184.00 stddev:2.75 (1.5%) stddev-sans-first:2.89 03:56:53 INFO - PROCESS | 13273 | Values: 184.0 181.0 179.0 181.0 187.0 186.0 186.0 181.0 184.0 181.0 03:56:53 INFO - PROCESS | 13273 | 03:56:53 INFO - PROCESS | 13273 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:70.00 stddev:1.25 (1.8%) stddev-sans-first:1.30 03:56:53 INFO - PROCESS | 13273 | Values: 70.0 70.0 73.0 70.0 70.0 70.0 73.0 71.0 70.0 70.0 03:56:53 INFO - PROCESS | 13273 | -------- Summary: end -------- 03:56:53 INFO - PROCESS | 13273 | 03:56:54 INFO - TEST-INFO | 13273: exit 0 03:56:54 INFO - TEST-OK | kraken | took 64497ms 03:56:54 INFO - SUITE-END | took 1187s 03:56:55 INFO - Completed test suite (00:19:47) 03:56:55 INFO - javascript benchmark 03:56:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2585.7931365490763, 2590.727973562776, 2623.6851577810667, 2641.181233817517, 2648.8410695358293, 4586.908261834761, 4613.261878099504, 4674.3222232776225, 4686.812527498901, 4713.293006049094, 4670.76646167692, 4676.649251306158, 4694.131585656647, 4699.718016918987, 4699.7415142167165, 4284.271673815459, 4307.935380969288, 4314.180305741915, 4337.609615134637, 4412.75729834859, 4387.341898715186, 4398.4062151609605, 4420.381146639473, 4422.447194100738, 4426.756528390937, 4339.045410009809, 4347.956520434786, 4369.650427965755, 4383.013821890081, 4405.471343438792, 4390.990072283361, 4426.380306757057, 4430.113977204572, 4451.109778044388, 4475.910481790346, 4227.640650544708, 4262.808173632163, 4291.8068686908855, 4339.349097635349, 4346.56534346566, 4722.929156062662, 4723.385959825235, 4730.314104454869, 4734.857954261378, 4811.49479304675, 5034.144195486776, 5083.8983220335385, 5091.719955402451, 5092.159793634046, 5130.4356520782685, 4940.580050695659, 4984.651074424792, 4987.351644286256, 5114.335136432277, 5162.716050617215, 4703.247480403119, 4718.363020992157, 4719.150552900511, 4719.5752382285755, 4722.0, 5118.61610379223, 5288.92066619001, 5290.127129023668, 5293.8411847643865, 5297.5232229099565, 5005.874853128701, 5007.574356179765, 5009.7495125243595, 5015.974920125376, 5081.618878584121, 5055.772490237948, 5060.291559181717, 5062.265971434122, 5067.442581316052, 5090.847274581768, 4814.8796280093275, 4900.26496025599, 4901.068796928572, 5023.824166154167, 5060.316857224301, 5010.3737032870895, 5072.087024335655, 5072.619553533426, 5124.180131178993, 5138.306328645585, 4297.462817147856, 4301.978490107592, 4303.720258183208, 4358.280883654225, 4366.323219900921, 3676.1361080146144, 3692.2430901665093, 3730.4404339349317, 3741.363968125371, 3796.620337966181, 4375.474943006796, 4395.978020109943, 4401.2517871961845, 4452.0, 4452.888677783017, 5069.1635880079375, 5076.13705670037, 5127.923081153711, 5128.0, 5165.48345165488, 4239.872803815891, 4261.998430368861, 4337.392765012901, 4351.0645211279725, 4405.66957478184, 4498.055408364215, 4536.251518499476, 4546.04533048057, 4552.271636538138, 4608.239640459286, 4726.26742854858, 4726.456457507362, 4735.337052812678, 4736.100140973204, 4793.945332026949, 4961.479044700399, 5052.671576347526, 5063.530347862757, 5064.063148317573, 5122.769475373691, 4643.8374656886845, 4645.140648979949, 4683.648726345469, 4692.178868698033, 4762.452317983476, 4884.3650325457465, 4899.804007839646, 4945.307656927961, 4948.084604348207, 4963.627727920492, 5105.897882042264, 5113.463086375877, 5126.051680438982, 5128.076946149728, 5184.896302074013, 4741.739204343657, 4839.370881785346, 4954.50454954516, 4956.263891845315, 4957.058158949788, 4843.152448321459, 4861.854144375674, 4876.561109500162, 4890.046440943982, 4946.455889852042, 4826.32431459603, 4834.758262086812, 4835.129676658235, 4843.782029808596, 4894.437139728977, 4837.612990960644, 4923.384576927884, 4926.162552366035, 4932.630052745986, 4989.575886049726, 4731.313959475926, 4796.760161991956, 4814.638902082428, 4847.151748444078, 4865.172920603577], "value": 4637.96153035556, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.9778008879645, 569.5614376929764, 580.2659635561014, 580.3036356372354, 590.0146754919284, 27895.0, 37415.0, 38881.22237555254, 38881.80559097204, 43189.0, 39246.430142794256, 39706.0, 39707.60292397075, 39713.801430992804, 39721.0, 7648.005759251303, 7796.0, 7800.492967957065, 7800.609969501531, 7803.648835802403, 7718.536887786723, 7804.414668899827, 7808.5314881107315, 7810.765677029698, 7815.335696465807, 7657.4639775215755, 7746.0, 7750.379969602446, 7752.496087754278, 7776.80557986052, 7710.653020614086, 7787.454878158531, 7818.843623127505, 7821.100573434071, 7827.530348179127, 7634.351080158138, 7747.4964127332105, 7749.418793590503, 7750.612469376509, 7751.961240193819, 38415.61584384176, 38450.23099538022, 38477.42283865744, 38806.417903731184, 38842.0, 3047.8171309721265, 3090.6909309069138, 3159.178613560468, 3323.4350160472777, 3447.3622379859808, 28296.434071318665, 28491.715082849114, 29084.27289317763, 29169.41661166786, 29275.853620731974, 3439.9312013759586, 3450.1719587298867, 3617.2584620152807, 3655.3054919565197, 3691.3171063353366, 188853.0, 190037.0, 190325.0, 190340.0, 191420.0, 30981.535276970862, 50107.0, 50420.24369634459, 50512.74743626258, 50570.0, 33570.49644255338, 33674.83162584171, 33691.32617347688, 33696.66303336984, 33706.0, 13319.06766526334, 13534.729305414034, 13537.864621353661, 13544.796828047587, 13550.0, 11132.109431245643, 11315.207935444605, 11323.32060076398, 11329.490172942073, 11337.376444295478, 7807.804804879924, 7808.68765249395, 7837.725679601187, 7894.6842126314305, 7895.644695988694, 3100.767442441781, 3127.280725433118, 3130.917939570206, 3151.401233765577, 3187.9362412751616, 858.978525536854, 899.3974037394961, 942.7313215733483, 970.3401686853008, 976.0727309056425, 25828.096016639327, 26832.32919177036, 26873.462530749668, 26982.32544186411, 27161.86419067892, 754.6679461037127, 892.4645212872355, 947.2422062350092, 1000.9099181073739, 1009.0, 13234.205947643171, 13876.167429954236, 14296.285185740671, 14306.713865722835, 14338.856611433961, 354298.0, 355809.0, 356027.0, 356158.0, 357043.0, 49695.50304496909, 50149.0, 50200.246996295085, 50221.24668129981, 50245.0, 1036.6009086501751, 1111.0556027376665, 1111.9388433636066, 1189.4469071881617, 1223.290491514937, 26862.0, 28759.712402875703, 28873.711262887104, 31266.0, 32022.35955280928, 46021.76989115033, 46566.767166163954, 46593.301100482844, 46623.30065048959, 46646.53353466422, 314456.0, 314729.0, 314754.0, 315795.0, 316040.0, 24989.375265618506, 25251.0, 30932.845335773178, 31833.840830795696, 38269.617303826606, 39169.41245881371, 39481.40777888276, 43076.13847722965, 43259.0, 43922.78038609787, 36895.815520922224, 37020.629793701715, 37094.36320459942, 37138.0, 37678.0, 36464.635353646125, 37189.44215836819, 37484.0, 37558.43662345012, 37831.0, 35984.64015359813, 36470.4529432064, 36884.262314754094, 37174.628253717114, 37620.0, 32305.35389292154, 34087.147821304665, 34700.82649586736, 35058.298834023684, 35171.47242791309, 25723.871380643726, 26292.342691432103, 26342.473150537266, 26363.472730544898, 26790.866045669645], "value": 16416.016130748696, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.7848716065298, 359.3047453178099, 365.3861512658733, 368.59638695628286, 386.06379529640617, 12439.191452555577, 13200.075994680376, 15160.620984475394, 16582.253798579062, 16785.24466399012, 15480.922595387008, 15564.0, 15777.763333549978, 15876.920615396906, 15903.12532810695, 4884.902301953976, 4891.951080489203, 4990.0, 5038.521340472649, 5043.36957880265, 3684.521012268401, 3871.051592359862, 5051.621128415383, 5067.873303167414, 5636.830895073133, 5919.615225010382, 6017.548683848707, 6026.0, 6026.8493287667725, 6030.698465076751, 5745.798897038625, 5924.526037916957, 5936.376680448534, 6005.729742161591, 6011.549133814981, 5302.045631786277, 5310.946890531122, 5311.946880531223, 5312.5218730314455, 5312.601554883399, 20026.1989520419, 20394.388168354973, 20684.58630827375, 20831.687524687142, 20955.5808883823, 1926.2872737087368, 2205.4817117977263, 2261.0390584001734, 2294.6443301288327, 2559.808014398909, 8822.779430514225, 9419.623215071457, 12506.874931250662, 12917.612471625866, 13696.383662735101, 1587.5078725595104, 1667.1830802906609, 1701.5661006443402, 1741.9564510887203, 1753.6580366828473, 57773.0, 70947.0, 73754.26245737527, 74187.62906185488, 74863.62568187233, 9754.170895473964, 9932.702018939442, 10011.349262297927, 10341.327813692085, 10349.172066234683, 13803.447862085404, 13804.516841910485, 13804.654883627989, 13805.17168969865, 13814.309284535733, 7220.819479512949, 7394.038774959221, 7521.0, 7574.091109066947, 7626.0, 7028.859422811515, 7048.541844780176, 7266.164391094986, 7278.563286202845, 7319.597422141834, 4217.514985776614, 4227.260229459894, 4285.785710714452, 4344.82620695175, 4447.533009034005, 1800.3878681248439, 1802.3331367394148, 1803.422904670493, 1849.6948003579528, 1874.878132921383, 796.0884786919061, 813.4265342933218, 817.6320655704957, 831.5303548461061, 880.0935036911991, 16653.250603722863, 16858.0, 16930.746038809426, 17030.91484542594, 17739.911300443415, 831.3432388413207, 834.2200042959852, 845.5138295480124, 855.2516548020482, 902.0348227396622, 9164.90835091654, 9585.712428627152, 9690.70927872165, 9701.320907536547, 9767.267454940766, 343689.0, 355411.0, 366024.0, 372055.0, 374562.0, 74380.62809686025, 76263.61868190735, 77685.6115719429, 81796.0, 86140.0, 895.3821862914568, 921.7326975177124, 930.02812061396, 932.47315266874, 938.9108034736689, 15549.922250388676, 15621.453249136226, 15895.443659471863, 16214.0, 16731.0, 36315.27369452649, 36724.44913326356, 36975.44536831896, 37096.0, 39137.41293880537, 50017.74991125167, 51236.0, 52695.20957185569, 53640.195397068295, 54730.726346368014, 9123.452592844451, 9809.95095024549, 10033.0, 10039.24705647094, 10430.16558675289, 10676.252662313564, 10888.564457421615, 10937.781244374908, 10950.123990080934, 11048.447577620926, 6481.708323125376, 6984.895226571504, 9781.902180978099, 9908.0, 10007.799844002933, 9659.565319560495, 9823.26325525574, 9848.507574621384, 9893.65372211969, 10111.443870587189, 9650.758731031781, 9872.654457093968, 9980.900190997998, 10169.03394177552, 10331.483425828528, 9622.0, 9755.756106097404, 9785.657501987396, 9940.751481213027, 10343.172546196136, 7429.07136607924, 7558.244175582618, 9598.376105553116, 9699.078587534173, 9986.500674966077], "value": 8268.498402440955, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1230.1389027680625, 1343.3350491506703, 1370.2669072046453, 1435.260840667056, 1658.8838781285315, 5853.326867410249, 6213.658248796314, 6650.20197576291, 6845.349691779285, 6852.074969879065, 6933.895991560131, 6966.547174433658, 6988.986596943453, 6991.23096459389, 7033.331833475811, 2047.5802460495638, 2078.2102800935622, 2078.2310545098335, 2078.6778049402365, 2080.864743791649, 2061.680439531875, 2098.0244186453297, 2099.1813192854797, 2127.7978592033733, 2134.4983928776724, 2052.404802607242, 2058.1561559760503, 2074.6265672179, 2076.9896150519226, 2080.6358887194756, 2029.3708950225403, 2046.2735728816206, 2046.9385918422472, 2049.1905697249504, 2049.5593447408805, 2001.8898960557165, 2018.2128969701828, 2030.604032213719, 2030.6344857925567, 2032.7560692716968, 6933.514653974224, 6965.129358830146, 7037.612931288777, 7041.0, 7048.506604537684, 3982.7012974027066, 4107.322291821846, 4118.691098167649, 4124.1133156371225, 4124.8556300529635, 2555.195113539229, 2719.877605507757, 2748.230495461274, 2762.6408566886375, 2766.1978026372326, 874.5670892907988, 884.3367474394204, 889.4663202078701, 1708.2227586448137, 1749.8337657922477, 8825.02924678285, 8835.911640883638, 8897.777555561099, 8919.509426981513, 8933.731988040368, 3554.298732962967, 3593.6765691087926, 3599.2441587266444, 3653.1232504199334, 3681.042928838521, 7234.312740289664, 7292.489525733148, 7301.342879140902, 7307.378872795765, 7346.0, 4107.589241075928, 4113.0, 4119.546849846514, 4143.875683729493, 4145.336746120606, 3326.6340702522702, 3441.2773317603583, 3644.927101457956, 3745.419459983707, 3783.9621603784162, 2995.176326510227, 3048.8018278811805, 3093.7215650591106, 3139.073973177918, 3161.9683803162134, 949.6676163342775, 953.1659797677032, 953.3612479638658, 961.927855410847, 964.9807003860024, 796.4424902568226, 816.3628807219602, 844.759243615579, 851.5954921412404, 853.1127627267696, 4597.747123908217, 4604.930926036112, 4629.745364005012, 4716.3632909557455, 4852.44196917359, 368.7252996517558, 375.6093662590875, 377.60540235454016, 384.5404741334079, 388.3630845413524, 3161.8893338733033, 3269.5095735639843, 3275.5086736989642, 3295.4562497187694, 3344.9331013379597, 7572.924270757332, 7702.845943081107, 7940.880886786703, 8002.51984880909, 8041.718539851077, 8116.715914943066, 8125.228103330174, 8135.064467586303, 8136.633851476698, 8137.959310203411, 6301.936980630135, 6340.619562826245, 6356.110144579762, 6361.9045714314325, 6551.967240163769, 4766.594839438687, 4774.1883879739835, 4809.0905002473, 4907.460179380194, 5002.899942001212, 7676.117246516722, 7682.116556596063, 7719.884201736866, 7778.416618753503, 7780.1052878919645, 7287.307705767944, 7557.584332861746, 7559.092908850753, 7565.962170189114, 7708.267714567107, 6032.125341825498, 6172.074188871526, 6173.104899789416, 6182.165407669907, 6184.072389141485, 5853.94146058534, 5990.910136348046, 6407.327230640715, 6462.192225971754, 6472.255690595642, 5904.763809447574, 5955.315138759098, 6045.879082418415, 6087.57386982907, 6142.0, 5922.73347699346, 5978.790742323998, 6032.909506357496, 6042.123892035543, 6059.454649081604, 5441.918371224514, 5548.528375088163, 5577.888442231214, 5630.18362337467, 5729.799457018984, 4098.754074755524, 4117.505899292104, 4190.580941905785, 4220.493540775126, 4308.2460569400855, 4074.6536544394057, 4089.488813898263, 4138.5654506276405, 4175.665946724315, 4213.325867861127], "value": 3649.163652197871, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.98296102233866, 284.2368241272184, 287.9064304101167, 291.7797063217271, 293.1425580177979, 4798.088363210992, 4816.807327706896, 4839.4192696876335, 4843.951560484394, 4844.418669759634, 4712.481627021033, 4764.332993380929, 4764.809407623699, 4767.499412561683, 4780.16347139251, 3512.2624248907696, 3613.7831730096145, 3639.290338384016, 3702.629737026303, 3730.899384681512, 3733.136204028831, 3742.101895545077, 3748.6063963283873, 3764.5106136202257, 3765.585785563586, 3713.4429835524616, 3728.5152930119048, 3730.7201959852982, 3731.3097077040834, 3757.849686012556, 3532.876349327774, 3617.186133120027, 3657.963420365802, 3673.2102597941303, 3725.18046029873, 3280.4095262852675, 3283.1627934876456, 3288.3752087103376, 3289.588801399825, 3295.110320213529, 4672.761718144694, 4684.407301517466, 4687.343771871941, 4701.388819453483, 4707.764611769432, 4169.687273454503, 4191.862150303336, 4251.681123915719, 4260.744355338689, 4270.829166833323, 4960.776765045582, 4964.677295975786, 4970.950290497085, 4973.378327709036, 5014.147594908874, 3589.300086483137, 3590.9461358079648, 3592.4552442449735, 3600.279944011208, 3611.56661200655, 4898.338724272249, 5209.218617207412, 5218.504242096995, 5231.843044708665, 5250.474952504757, 3530.5763308402643, 3547.4856145858707, 3553.680168784822, 3575.1955809942556, 3577.7853328800356, 3584.6594573515476, 3603.819809009539, 3624.2751449709635, 3650.3976843821, 3656.634336566375, 4166.1251137261515, 4166.8749937501925, 4203.528764932249, 4204.3693445983345, 4204.495460544754, 4856.902861942742, 4985.850424487271, 4991.80032798684, 5086.949130508721, 5090.847274581768, 1234.333459931627, 1239.4112796421807, 1240.9193402428814, 1242.571312897049, 1244.2223610243598, 763.3320844261272, 772.5557804262571, 785.5012067337168, 803.5656353409137, 813.4834380168636, 4293.175400454794, 4305.913881722348, 4434.5343738907595, 4449.421575195269, 4468.821247150143, 5121.667091639031, 5150.8969820604125, 5163.845084647466, 5174.7153906535505, 5207.062728708869, 4478.373027776114, 4482.843100491467, 4488.640908727294, 4500.909981800346, 4502.842400515966, 2596.0524408591104, 2742.3966727319957, 2746.763956219709, 2756.8483733394855, 2766.2531116598807, 4883.194272944996, 4888.902221955541, 4889.731064791399, 4896.804127834918, 4897.338859254026, 5046.34397528319, 5261.579073674096, 5282.207668849626, 5288.65623734456, 5295.0, 4870.732109733999, 4897.14299997499, 4902.7988142904505, 4942.752862356868, 4944.505549445027, 5152.510511501401, 5229.973850130725, 5232.424433312409, 5234.712090835041, 5238.711870846988, 4914.36113305268, 5117.641765076409, 5125.589952803842, 5131.897362052813, 5143.6399452037995, 4898.951010489849, 4904.043711476371, 4908.9754551227015, 4911.4106307243355, 4921.655484116078, 3547.3614749345365, 3563.590187128513, 3568.3576956148145, 3573.857045718142, 3584.462330650423, 4943.467525067241, 5216.452272511332, 5223.634345595924, 5235.136202526541, 5242.816501422432, 5029.597632189343, 5032.7483625819295, 5050.949490505195, 5053.393592768891, 5058.898822023612, 5000.699958002531, 5014.84955451337, 5029.924551131663, 5034.345535080416, 5036.345275114211, 4798.49615790337, 4952.0, 4955.529224723646, 4964.081644895706, 4969.925451118163, 4838.032393521239, 4898.755062246944, 4952.232403977389, 5015.219597043143, 5053.31780209667, 4875.658703890694, 4934.5805606523845, 4953.826616068421, 4964.478729733326, 4976.850694479172], "value": 3758.5001011123945, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.2508989212946, 630.9999999999999, 652.4226059936955, 674.9358810912962, 720.2977097330103, 12297.877021229786, 12384.93807530961, 12986.74026519469, 13005.479780808768, 13011.934940325309, 14355.138691678507, 14545.490907818228, 14591.34338954747, 14591.635209119777, 14597.78103328451, 625.7371903800392, 639.9264084630281, 787.1813314153273, 810.205998121838, 814.242754238558, 773.5010917957914, 790.3716545346434, 797.0594698256056, 801.8115742800437, 802.8394321135767, 809.3808236698901, 810.3274282345639, 810.3800592546677, 810.8540462716709, 811.0389188811248, 647.5499527828161, 665.4310564467407, 805.963731632078, 806.6853926968516, 807.4186585658375, 593.967331796751, 609.2536642612808, 611.6024584020378, 614.008376471999, 614.732591322776, 13051.412686429134, 13054.934725326408, 13064.608061758163, 13073.803892941518, 13138.86861131386, 11726.882731172664, 11889.583864564698, 12143.149979501439, 12275.38623068843, 12377.0, 10666.306690065121, 10769.246152769309, 11108.389038602874, 11214.775704485864, 11613.419329033515, 3979.98010009951, 4003.199360127957, 4032.4556184914954, 4055.3916912463364, 4110.712250142491, 51319.230211546484, 51515.22727159096, 52166.47833521654, 52625.7368713154, 52865.735671321396, 9579.233661307078, 9832.950835245778, 9875.901240987498, 9884.0, 9993.300468967103, 17246.655066898842, 17248.396306129227, 17257.223424945907, 17347.82652173462, 17468.213930373164, 6242.781502647385, 6484.675766211671, 6495.772647957393, 6510.869782604322, 6700.865982680319, 3591.2996965591983, 3632.20091579852, 3673.7979411132646, 3780.0549862534367, 3847.576766555733, 2697.9595306070423, 2759.089500464842, 2776.5002299586267, 2783.234610482093, 2786.414852880918, 476.2499063974185, 482.4524165072668, 488.482208858611, 491.6632107006712, 492.4017318957484, 516.8811173430132, 539.7840863654569, 540.2571464236675, 572.6249306704116, 585.3210276079727, 7464.216257293015, 7469.701211951569, 7603.467757256939, 7724.459287849797, 8215.753527394188, 461.9491855895849, 502.52762403340745, 515.4896652314256, 563.144021087944, 585.8418227078665, 3630.8366123524506, 3649.1948546452204, 3761.9059523511582, 3817.5037245158505, 3888.0862997195636, 68557.0, 69643.65178174178, 71560.2843971564, 71592.64203678949, 73847.0, 40933.38599921003, 41827.58172418237, 61841.0, 65358.34641653618, 66649.33350666432, 57941.710291448275, 58364.1635836413, 58710.41289587135, 58773.706131469065, 59155.70422147862, 7000.754973576104, 7266.273372662691, 7410.9258907412395, 7441.293077157661, 7616.619169041636, 37833.432498513095, 39291.21417571575, 39625.40561891632, 39640.80179599083, 39955.0, 48947.0, 49328.0, 53306.20040699315, 54782.17826732682, 55167.207443217885, 9393.107654772786, 9467.431954082776, 9632.807343852943, 9663.178629816544, 9979.950100249453, 10649.627263045757, 10734.785304294026, 10809.189310801565, 10928.945355273172, 11119.499622516845, 9946.751331216778, 9954.502274886081, 10177.592896284363, 10366.06705396518, 10534.157267418741, 10315.587376504856, 10385.428801415994, 10441.68674939753, 10495.21285903545, 10554.261201715806, 9765.60937562518, 9766.0, 9821.214302855897, 9869.0, 9927.801443971224, 8154.504295391137, 8424.157584241526, 8498.107698691549, 8760.4305720128, 8831.116888311117, 8023.83952320962, 8611.526366049928, 8694.695685650971, 8716.477011379338, 8729.91270087291], "value": 6031.33850952527, "unit": "score"}], "name": "dromaeo_css", "value": 6111.052145686235, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 117.0, 118.0, 116.0, 116.0, 118.0, 116.0, 117.0, 116.0, 118.0], "value": 116.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 132.0, 131.0, 185.0, 128.0, 131.0, 130.0, 144.0, 168.0, 130.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 161.0, 160.0, 162.0, 162.0, 160.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 106.0, 78.0, 79.0, 86.0, 78.0, 99.0, 77.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 120.0, 83.0, 83.0, 83.0, 104.0, 83.0, 85.0, 119.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 147.0, 149.0, 147.0, 146.0, 146.0, 148.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 84.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 64.0, 63.0, 63.0, 63.0, 63.0, 64.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 66.0, 67.0, 69.0, 67.0, 66.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 92.0, 85.0, 87.0, 90.0, 84.0, 85.0, 83.0, 84.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 143.0, 143.0, 153.0, 142.0, 143.0, 144.0, 151.0, 187.0, 141.0], "value": 148.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 181.0, 179.0, 181.0, 187.0, 186.0, 186.0, 181.0, 184.0, 181.0], "value": 183.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 73.0, 70.0, 70.0, 70.0, 73.0, 71.0, 70.0, 70.0], "value": 70.7, "unit": "score"}], "name": "kraken", "value": 1563.5, "alertThreshold": 2.0}]} 03:56:55 INFO - Return code: 0 03:56:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:56:55 INFO - # TBPL SUCCESS # 03:56:55 INFO - Running post-action listener: _resource_record_post_action 03:56:55 INFO - [mozharness: 2016-11-04 10:56:55.169329Z] Finished run-tests step (success) 03:56:55 INFO - Running post-run listener: _resource_record_post_run 03:56:55 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403382272; Read time: 12; Write time: 203296 03:56:55 INFO - TinderboxPrint: CPU usage
13.0% 03:56:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 03:56:55 INFO - TinderboxPrint: I/O write bytes / time
403,382,272 / 203,296 03:56:55 INFO - TinderboxPrint: CPU idle
8,353.7 (87.0%) 03:56:55 INFO - TinderboxPrint: CPU user
1,204.1 (12.5%) 03:56:55 INFO - TinderboxPrint: Swap in / out
0 / 0 03:56:55 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 100139008; Read time: 0; Write time: 46084 03:56:55 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 292012032; Read time: 0; Write time: 150808 03:56:55 INFO - Running post-run listener: _upload_blobber_files 03:56:55 INFO - Blob upload gear active. 03:56:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:56:55 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 03:56:55 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:56:55 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:56:56 INFO - (blobuploader) - INFO - Open directory for files ... 03:56:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:56:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:56:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:57 INFO - (blobuploader) - INFO - Done attempting. 03:56:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:56:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:57:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:00 INFO - (blobuploader) - INFO - Done attempting. 03:57:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:57:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:57:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:01 INFO - (blobuploader) - INFO - Done attempting. 03:57:01 INFO - (blobuploader) - INFO - Iteration through files over. 03:57:01 INFO - Return code: 0 03:57:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:57:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:57:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/07b103182a4c44a0547ba0d4d0786b4e1e93ebdf75c24c1a5e2904df7e5e9c45cdccb66165dcede2789945e385a77ec906882beb5b05aa9aa2f222c9fe680665", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/ab6a8bb2b150575390b946e5769c438a0e32e538f7a971adf4f9249e6f767db2adb19dfe6c60d5805d8309383fe8477c82d1f3573f9b2f9ed5395838a5c2ddfa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/1d096246a05ba2f9a0125c5ce9df8b94b0abc2603fe77d2e7d7df1a4c6534c973deb1f92b5b565fa12b17060b85a6a61fda97edd1a7e19ceb692ba340f7338d0"} 03:57:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:57:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:57:01 INFO - Contents: 03:57:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/07b103182a4c44a0547ba0d4d0786b4e1e93ebdf75c24c1a5e2904df7e5e9c45cdccb66165dcede2789945e385a77ec906882beb5b05aa9aa2f222c9fe680665", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/ab6a8bb2b150575390b946e5769c438a0e32e538f7a971adf4f9249e6f767db2adb19dfe6c60d5805d8309383fe8477c82d1f3573f9b2f9ed5395838a5c2ddfa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/1d096246a05ba2f9a0125c5ce9df8b94b0abc2603fe77d2e7d7df1a4c6534c973deb1f92b5b565fa12b17060b85a6a61fda97edd1a7e19ceb692ba340f7338d0"} 03:57:01 INFO - Running post-run listener: copy_logs_to_upload_dir 03:57:01 INFO - Copying logs to upload dir... 03:57:01 INFO - mkdir: /builds/slave/test/build/upload/logs 03:57:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.479968 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-04 03:57:01.021953) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-04 03:57:01.025698) ========= 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=00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/07b103182a4c44a0547ba0d4d0786b4e1e93ebdf75c24c1a5e2904df7e5e9c45cdccb66165dcede2789945e385a77ec906882beb5b05aa9aa2f222c9fe680665", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/ab6a8bb2b150575390b946e5769c438a0e32e538f7a971adf4f9249e6f767db2adb19dfe6c60d5805d8309383fe8477c82d1f3573f9b2f9ed5395838a5c2ddfa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/1d096246a05ba2f9a0125c5ce9df8b94b0abc2603fe77d2e7d7df1a4c6534c973deb1f92b5b565fa12b17060b85a6a61fda97edd1a7e19ceb692ba340f7338d0"} build_url:https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011332 build_url: 'https://queue.taskcluster.net/v1/task/G6rusiFpRm6xNBM-6WRz6g/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/Cedar/sha512/07b103182a4c44a0547ba0d4d0786b4e1e93ebdf75c24c1a5e2904df7e5e9c45cdccb66165dcede2789945e385a77ec906882beb5b05aa9aa2f222c9fe680665", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/ab6a8bb2b150575390b946e5769c438a0e32e538f7a971adf4f9249e6f767db2adb19dfe6c60d5805d8309383fe8477c82d1f3573f9b2f9ed5395838a5c2ddfa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/1d096246a05ba2f9a0125c5ce9df8b94b0abc2603fe77d2e7d7df1a4c6534c973deb1f92b5b565fa12b17060b85a6a61fda97edd1a7e19ceb692ba340f7338d0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-04 03:57:01.051154) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 03:57:01.051488) ========= 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=00204705a9daa57ed339a427000001b9-1478255692.564583-1787777788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 03:57:01.137334) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-04 03:57:01.137692) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-04 03:57:01.138055) ========= ========= Total master_lag: 0.18 =========