builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1476351343.57 results: success (0) buildid: 20161012233221 builduid: 493304dc12664a8c99e1def246f2c279 revision: 68be44803595 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 02:35:43.573428) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 02:35:43.573818) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 02:35:43.574157) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 02:35:43.608437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 02:35:43.608815) ========= 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=0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-13 02:35:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.5M=0s 2016-10-13 02:35:44 (50.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084658 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 02:35:43.707705) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 02:35:43.707994) ========= 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=0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018163 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 02:35:43.757213) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 02:35:43.757545) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 68be44803595 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 68be44803595 --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=0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-13 02:35:44,192 Setting DEBUG logging. 2016-10-13 02:35:44,192 attempt 1/10 2016-10-13 02:35:44,192 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/68be44803595?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 02:35:45,250 unpacking tar archive at: autoland-68be44803595/testing/mozharness/ program finished with exit code 0 elapsedTime=1.379572 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 02:35:45.153861) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 02:35:45.154411) ========= script_repo_revision: 68be44803595 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 02:35:45.155104) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 02:35:45.155571) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 02:35:45.167846) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-13 02:35:45.168327) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:35:45 INFO - MultiFileLogger online at 20161013 02:35:45 in /builds/slave/test 02:35:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 02:35:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:35:45 INFO - {'append_to_log': False, 02:35:45 INFO - 'base_work_dir': '/builds/slave/test', 02:35:45 INFO - 'blob_upload_branch': 'Autoland', 02:35:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:35:45 INFO - 'branch': 'Autoland', 02:35:45 INFO - 'buildbot_json_path': 'buildprops.json', 02:35:45 INFO - 'config_files': ('talos/linux_config.py',), 02:35:45 INFO - 'default_actions': ('clobber', 02:35:45 INFO - 'read-buildbot-config', 02:35:45 INFO - 'download-and-extract', 02:35:45 INFO - 'populate-webroot', 02:35:45 INFO - 'create-virtualenv', 02:35:45 INFO - 'install', 02:35:45 INFO - 'run-tests'), 02:35:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:35:45 INFO - 'download_minidump_stackwalk': True, 02:35:45 INFO - 'download_symbols': 'ondemand', 02:35:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:35:45 INFO - 'tooltool.py': '/tools/tooltool.py', 02:35:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:35:45 INFO - '/tools/misc-python/virtualenv.py')}, 02:35:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:35:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:35:45 INFO - 'installer_path': 'installer.exe', 02:35:45 INFO - 'log_level': 'info', 02:35:45 INFO - 'log_name': 'talos', 02:35:45 INFO - 'log_to_console': True, 02:35:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:35:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:35:45 INFO - 'opt_config_files': (), 02:35:45 INFO - 'pip_index': False, 02:35:45 INFO - 'sps_profile': False, 02:35:45 INFO - 'sps_profile_interval': 0, 02:35:45 INFO - 'suite': 'dromaeojs', 02:35:45 INFO - 'system_bits': '32', 02:35:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:35:45 INFO - 'title': 'talos-linux64-ix-017', 02:35:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:35:45 INFO - 'use_talos_json': True, 02:35:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:35:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:35:45 INFO - 'work_dir': 'build'} 02:35:45 INFO - [mozharness: 2016-10-13 09:35:45.710590Z] Running clobber step. 02:35:45 INFO - Running pre-action listener: _resource_record_pre_action 02:35:45 INFO - Running main action method: clobber 02:35:45 INFO - rmtree: /builds/slave/test/build 02:35:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:35:46 INFO - Running post-action listener: _resource_record_post_action 02:35:46 INFO - [mozharness: 2016-10-13 09:35:46.187522Z] Finished clobber step (success) 02:35:46 INFO - [mozharness: 2016-10-13 09:35:46.187622Z] Running read-buildbot-config step. 02:35:46 INFO - Running pre-action listener: _resource_record_pre_action 02:35:46 INFO - Running main action method: read_buildbot_config 02:35:46 INFO - Using buildbot properties: 02:35:46 INFO - { 02:35:46 INFO - "project": "", 02:35:46 INFO - "product": "firefox", 02:35:46 INFO - "script_repo_revision": "production", 02:35:46 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 02:35:46 INFO - "repository": "", 02:35:46 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 02:35:46 INFO - "buildid": "20161012233221", 02:35:46 INFO - "pgo_build": "True", 02:35:46 INFO - "basedir": "/builds/slave/test", 02:35:46 INFO - "buildnumber": 338, 02:35:46 INFO - "slavename": "talos-linux64-ix-017", 02:35:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:35:46 INFO - "platform": "ubuntu64_hw", 02:35:46 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 02:35:46 INFO - "branch": "autoland", 02:35:46 INFO - "repo_path": "integration/autoland", 02:35:46 INFO - "revision": "68be44803595", 02:35:46 INFO - "stage_platform": "linux64-pgo", 02:35:46 INFO - "builduid": "493304dc12664a8c99e1def246f2c279", 02:35:46 INFO - "slavebuilddir": "test" 02:35:46 INFO - } 02:35:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 02:35:46 INFO - Running post-action listener: _resource_record_post_action 02:35:46 INFO - [mozharness: 2016-10-13 09:35:46.190055Z] Finished read-buildbot-config step (success) 02:35:46 INFO - [mozharness: 2016-10-13 09:35:46.190144Z] Running download-and-extract step. 02:35:46 INFO - Running pre-action listener: _resource_record_pre_action 02:35:46 INFO - Running main action method: download_and_extract 02:35:46 INFO - mkdir: /builds/slave/test/build/tests 02:35: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')]} 02:35:46 INFO - trying https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:35:46 INFO - Downloading https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/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 02:35:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/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 02:35:46 INFO - Downloaded 1361 bytes. 02:35:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:35:46 INFO - Using the following test package requirements: 02:35:46 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 02:35:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:35:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:35:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:35:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:35:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:35:46 INFO - u'jsshell-linux-x86_64.zip'], 02:35:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:35:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:35:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 02:35:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:35:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:35:46 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:35:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:35:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:35:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:35:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:35:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:35:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:35:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 02:35:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:35:46 INFO - Fetch https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:35:47 INFO - Http code: 200 02:35:47 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 02:35:47 INFO - x-amz-cf-id: RkTSAcfvC3eLyAa09m-SJ8-Qz0gTqonF5xd330iob4ti2DR2CI5W3Q== 02:35:47 INFO - x-amz-version-id: gh9duP_hplMKsd54UCKPbdQ091_skQZo 02:35:47 INFO - Expected file size: 22117380 02:35:47 INFO - Obtained file size: 22117380 02:35:51 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:35:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 02:35:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:35:51 INFO - Fetch https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:35:52 INFO - Http code: 200 02:35:52 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 02:35:52 INFO - x-amz-cf-id: -rGKUQMokDF-L00d8L6GtERGOAH-Dimc9IEbyUgWbGc9q_ZxZKM8Lw== 02:35:52 INFO - x-amz-version-id: gh9duP_hplMKsd54UCKPbdQ091_skQZo 02:35:52 INFO - Expected file size: 22117380 02:35:52 INFO - Obtained file size: 22117380 02:35:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 02:35:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:35:57 INFO - Fetch https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 02:35:57 INFO - Http code: 200 02:35:57 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 02:35:57 INFO - x-amz-cf-id: ElWY1FY86MVLVPFc-1JnoxWoF9YY_lHI0fzjPJm-n-Whbwav2dg2wA== 02:35:57 INFO - x-amz-version-id: oUT4jLSVBnT6mLN6cCK.RGPoPRi.TJb7 02:35:58 INFO - Expected file size: 14409006 02:35:58 INFO - Obtained file size: 14409006 02:35:58 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')]} 02:35:58 INFO - trying https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:35:58 INFO - Downloading https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/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 02:35:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/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 02:36:00 INFO - Downloaded 59775667 bytes. 02:36:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:36:00 INFO - mkdir: /builds/slave/test/properties 02:36:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:36:00 INFO - Writing to file /builds/slave/test/properties/build_url 02:36:00 INFO - Contents: 02:36:00 INFO - build_url:https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:36:01 INFO - Running post-action listener: _resource_record_post_action 02:36:01 INFO - Running post-action listener: set_extra_try_arguments 02:36:01 INFO - [mozharness: 2016-10-13 09:36:01.568224Z] Finished download-and-extract step (success) 02:36:01 INFO - [mozharness: 2016-10-13 09:36:01.568451Z] Running populate-webroot step. 02:36:01 INFO - Running pre-action listener: _resource_record_pre_action 02:36:01 INFO - Running main action method: populate_webroot 02:36:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:36:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:36:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:36:01 INFO - '--tppagecycles', 02:36:01 INFO - '7'], 02:36:01 INFO - 'tests': ['tsvgm']}}, 02:36:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:36:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:36:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:36:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:36:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:01 INFO - 'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:36:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:36:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:01 INFO - 'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['damp', 'tps']}, 02:36:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:01 INFO - 'tests': ['damp', 'tps']}, 02:36:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['dromaeo_dom']}, 02:36:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:36:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['basic_compositor_video']}, 02:36:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:36:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['a11yr', 02:36:01 INFO - 'ts_paint', 02:36:01 INFO - 'tpaint', 02:36:01 INFO - 'sessionrestore', 02:36:01 INFO - 'sessionrestore_no_auto_restore', 02:36:01 INFO - 'tabpaint']}, 02:36:01 INFO - 'other-e10s': {'tests': ['a11yr', 02:36:01 INFO - 'ts_paint', 02:36:01 INFO - 'tpaint', 02:36:01 INFO - 'sessionrestore', 02:36:01 INFO - 'sessionrestore_no_auto_restore', 02:36:01 INFO - 'tabpaint']}, 02:36:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:36:01 INFO - 'ts_paint', 02:36:01 INFO - 'tpaint', 02:36:01 INFO - 'sessionrestore', 02:36:01 INFO - 'sessionrestore_no_auto_restore', 02:36:01 INFO - 'tabpaint']}, 02:36:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:36:01 INFO - 'ts_paint', 02:36:01 INFO - 'tpaint', 02:36:01 INFO - 'sessionrestore', 02:36:01 INFO - 'sessionrestore_no_auto_restore', 02:36:01 INFO - 'tabpaint']}, 02:36:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['a11yr', 02:36:01 INFO - 'ts_paint', 02:36:01 INFO - 'tpaint', 02:36:01 INFO - 'sessionrestore', 02:36:01 INFO - 'sessionrestore_no_auto_restore', 02:36:01 INFO - 'tabpaint']}, 02:36:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['a11yr', 02:36:01 INFO - 'ts_paint', 02:36:01 INFO - 'tpaint', 02:36:01 INFO - 'sessionrestore', 02:36:01 INFO - 'sessionrestore_no_auto_restore', 02:36:01 INFO - 'tabpaint']}, 02:36:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['tsvgx', 02:36:01 INFO - 'tsvgr_opacity', 02:36:01 INFO - 'tart', 02:36:01 INFO - 'tscrollx', 02:36:01 INFO - 'cart']}, 02:36:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:36:01 INFO - 'tsvgr_opacity', 02:36:01 INFO - 'tart', 02:36:01 INFO - 'tscrollx', 02:36:01 INFO - 'cart']}, 02:36:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:01 INFO - 'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['tp5o']}, 02:36:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:01 INFO - 'tests': ['tp5o']}, 02:36:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:01 INFO - 'talos_options': ['--disable-e10s', 02:36:01 INFO - '--xperf_path', 02:36:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:36:01 INFO - 'tests': ['tp5n']}, 02:36:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:01 INFO - 'talos_options': ['--xperf_path', 02:36:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:36:01 INFO - 'tests': ['tp5n']}}, 02:36:01 INFO - 'talos.zip': {'path': '', 02:36:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:36:01 INFO - Running post-action listener: _resource_record_post_action 02:36:01 INFO - [mozharness: 2016-10-13 09:36:01.589969Z] Finished populate-webroot step (success) 02:36:01 INFO - [mozharness: 2016-10-13 09:36:01.590066Z] Running create-virtualenv step. 02:36:01 INFO - Running pre-action listener: _resource_record_pre_action 02:36:01 INFO - Running main action method: create_virtualenv 02:36:01 INFO - Creating virtualenv /builds/slave/test/build/venv 02:36:01 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 02:36:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:36:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:36:01 INFO - Using real prefix '/usr' 02:36:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:36:02 INFO - Installing distribute.............................................................................................................................................................................................done. 02:36:04 INFO - Installing pip.................done. 02:36:04 INFO - Return code: 0 02:36:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:36:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:36:04 INFO - Reading from file tmpfile_stdout 02:36:04 INFO - Output received: 02:36:04 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) 02:36:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:36:04 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')]} 02:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:04 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')]} 02:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:04 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 0x7f57aa31bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b790>, '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 0x293c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293cb20>, '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': '0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756', '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 02:36:04 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 02:36:04 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 02:36:04 INFO - Using env: {'DISPLAY': ':0', 02:36:04 INFO - 'HOME': '/home/cltbld', 02:36:04 INFO - 'LANG': 'en_US.UTF-8', 02:36:04 INFO - 'LANGUAGE': 'en_US:en', 02:36:04 INFO - 'LOGNAME': 'cltbld', 02:36:04 INFO - 'MAIL': '/var/mail/cltbld', 02:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:04 INFO - 'MOZ_NO_REMOTE': '1', 02:36:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:04 INFO - 'NO_EM_RESTART': '1', 02:36:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:04 INFO - 'PWD': '/builds/slave/test', 02:36:04 INFO - 'SHELL': '/bin/bash', 02:36:04 INFO - 'SHLVL': '1', 02:36:04 INFO - 'TERM': 'linux', 02:36:04 INFO - 'TMOUT': '86400', 02:36:04 INFO - 'USER': 'cltbld', 02:36:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756', 02:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:04 INFO - '_': '/tools/buildbot/bin/python'} 02:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:04 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 02:36:04 INFO - Cleaning up... 02:36:04 INFO - Return code: 0 02:36:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:36:04 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')]} 02:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:04 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')]} 02:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:04 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 0x7f57aa31bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b790>, '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 0x293c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293cb20>, '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': '0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756', '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 02:36:04 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 02:36:04 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 02:36:04 INFO - Using env: {'DISPLAY': ':0', 02:36:04 INFO - 'HOME': '/home/cltbld', 02:36:04 INFO - 'LANG': 'en_US.UTF-8', 02:36:04 INFO - 'LANGUAGE': 'en_US:en', 02:36:04 INFO - 'LOGNAME': 'cltbld', 02:36:04 INFO - 'MAIL': '/var/mail/cltbld', 02:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:04 INFO - 'MOZ_NO_REMOTE': '1', 02:36:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:04 INFO - 'NO_EM_RESTART': '1', 02:36:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:04 INFO - 'PWD': '/builds/slave/test', 02:36:04 INFO - 'SHELL': '/bin/bash', 02:36:04 INFO - 'SHLVL': '1', 02:36:04 INFO - 'TERM': 'linux', 02:36:04 INFO - 'TMOUT': '86400', 02:36:04 INFO - 'USER': 'cltbld', 02:36:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756', 02:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:04 INFO - '_': '/tools/buildbot/bin/python'} 02:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:04 INFO - Downloading/unpacking psutil>=3.1.1 02:36:04 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 02:36:04 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 02:36:04 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 02:36:04 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 02:36:04 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 02:36:04 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 02:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:36:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:36:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:36:06 INFO - Installing collected packages: psutil 02:36:06 INFO - Running setup.py install for psutil 02:36:06 INFO - building 'psutil._psutil_linux' extension 02:36:06 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 02:36:07 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 02:36:07 INFO - building 'psutil._psutil_posix' extension 02:36:07 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 02:36:07 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 02:36:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:36:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:36:07 INFO - Successfully installed psutil 02:36:07 INFO - Cleaning up... 02:36:07 INFO - Return code: 0 02:36:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f57aa31bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b790>, '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 0x293c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293cb20>, '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': '0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756', '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 02:36:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:36:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:36:07 INFO - Using env: {'DISPLAY': ':0', 02:36:07 INFO - 'HOME': '/home/cltbld', 02:36:07 INFO - 'LANG': 'en_US.UTF-8', 02:36:07 INFO - 'LANGUAGE': 'en_US:en', 02:36:07 INFO - 'LOGNAME': 'cltbld', 02:36:07 INFO - 'MAIL': '/var/mail/cltbld', 02:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:07 INFO - 'MOZ_NO_REMOTE': '1', 02:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:07 INFO - 'NO_EM_RESTART': '1', 02:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:07 INFO - 'PWD': '/builds/slave/test', 02:36:07 INFO - 'SHELL': '/bin/bash', 02:36:07 INFO - 'SHLVL': '1', 02:36:07 INFO - 'TERM': 'linux', 02:36:07 INFO - 'TMOUT': '86400', 02:36:07 INFO - 'USER': 'cltbld', 02:36:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756', 02:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:07 INFO - '_': '/tools/buildbot/bin/python'} 02:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:36:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:36:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:36:09 INFO - Installing collected packages: mozsystemmonitor 02:36:09 INFO - Running setup.py install for mozsystemmonitor 02:36:09 INFO - Successfully installed mozsystemmonitor 02:36:09 INFO - Cleaning up... 02:36:09 INFO - Return code: 0 02:36:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:36:09 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')]} 02:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:09 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')]} 02:36:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:09 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 0x7f57aa31bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b790>, '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 0x293c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293cb20>, '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': '0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756', '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 02:36:09 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 02:36:09 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 02:36:09 INFO - Using env: {'DISPLAY': ':0', 02:36:09 INFO - 'HOME': '/home/cltbld', 02:36:09 INFO - 'LANG': 'en_US.UTF-8', 02:36:09 INFO - 'LANGUAGE': 'en_US:en', 02:36:09 INFO - 'LOGNAME': 'cltbld', 02:36:09 INFO - 'MAIL': '/var/mail/cltbld', 02:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:09 INFO - 'MOZ_NO_REMOTE': '1', 02:36:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:09 INFO - 'NO_EM_RESTART': '1', 02:36:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:09 INFO - 'PWD': '/builds/slave/test', 02:36:09 INFO - 'SHELL': '/bin/bash', 02:36:09 INFO - 'SHLVL': '1', 02:36:09 INFO - 'TERM': 'linux', 02:36:09 INFO - 'TMOUT': '86400', 02:36:09 INFO - 'USER': 'cltbld', 02:36:09 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756', 02:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:09 INFO - '_': '/tools/buildbot/bin/python'} 02:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:09 INFO - Downloading/unpacking jsonschema==2.5.1 02:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:36:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:12 INFO - Downloading functools32-3.2.3-2.tar.gz 02:36:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:36:12 INFO - warning: no files found matching '*.txt' 02:36:12 INFO - no previously-included directories found matching 'build' 02:36:12 INFO - no previously-included directories found matching 'dist' 02:36:12 INFO - no previously-included directories found matching '.git*' 02:36:12 INFO - Installing collected packages: jsonschema, functools32 02:36:12 INFO - Running setup.py install for functools32 02:36:12 INFO - warning: no files found matching '*.txt' 02:36:12 INFO - no previously-included directories found matching 'build' 02:36:12 INFO - no previously-included directories found matching 'dist' 02:36:12 INFO - no previously-included directories found matching '.git*' 02:36:12 INFO - Successfully installed jsonschema functools32 02:36:12 INFO - Cleaning up... 02:36:12 INFO - Return code: 0 02:36:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:36:12 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')]} 02:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:12 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')]} 02:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:12 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 0x7f57aa31bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b790>, '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 0x293c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293cb20>, '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': '0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756', '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 02:36:12 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 02:36:12 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 02:36:12 INFO - Using env: {'DISPLAY': ':0', 02:36:12 INFO - 'HOME': '/home/cltbld', 02:36:12 INFO - 'LANG': 'en_US.UTF-8', 02:36:12 INFO - 'LANGUAGE': 'en_US:en', 02:36:12 INFO - 'LOGNAME': 'cltbld', 02:36:12 INFO - 'MAIL': '/var/mail/cltbld', 02:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:12 INFO - 'MOZ_NO_REMOTE': '1', 02:36:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:12 INFO - 'NO_EM_RESTART': '1', 02:36:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:12 INFO - 'PWD': '/builds/slave/test', 02:36:12 INFO - 'SHELL': '/bin/bash', 02:36:12 INFO - 'SHLVL': '1', 02:36:12 INFO - 'TERM': 'linux', 02:36:12 INFO - 'TMOUT': '86400', 02:36:12 INFO - 'USER': 'cltbld', 02:36:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756', 02:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:12 INFO - '_': '/tools/buildbot/bin/python'} 02:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:36:12 INFO - Cleaning up... 02:36:12 INFO - Return code: 0 02:36:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:36:12 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')]} 02:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:12 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')]} 02:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:12 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 0x7f57aa31bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b790>, '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 0x293c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293cb20>, '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': '0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756', '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 02:36:12 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 02:36:12 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 02:36:12 INFO - Using env: {'DISPLAY': ':0', 02:36:12 INFO - 'HOME': '/home/cltbld', 02:36:12 INFO - 'LANG': 'en_US.UTF-8', 02:36:12 INFO - 'LANGUAGE': 'en_US:en', 02:36:12 INFO - 'LOGNAME': 'cltbld', 02:36:12 INFO - 'MAIL': '/var/mail/cltbld', 02:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:12 INFO - 'MOZ_NO_REMOTE': '1', 02:36:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:12 INFO - 'NO_EM_RESTART': '1', 02:36:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:12 INFO - 'PWD': '/builds/slave/test', 02:36:12 INFO - 'SHELL': '/bin/bash', 02:36:12 INFO - 'SHLVL': '1', 02:36:12 INFO - 'TERM': 'linux', 02:36:12 INFO - 'TMOUT': '86400', 02:36:12 INFO - 'USER': 'cltbld', 02:36:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756', 02:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:12 INFO - '_': '/tools/buildbot/bin/python'} 02:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:12 INFO - Downloading/unpacking blobuploader==1.2.4 02:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:14 INFO - Downloading blobuploader-1.2.4.tar.gz 02:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:36:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:36:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:36:15 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 02:36:15 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 02:36:15 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 02:36:15 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 02:36:15 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 02:36:15 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 02:36:15 INFO - Downloading docopt-0.6.1.tar.gz 02:36:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:36:15 INFO - Installing collected packages: blobuploader, requests, docopt 02:36:15 INFO - Running setup.py install for blobuploader 02:36:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:36:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:36:15 INFO - Running setup.py install for requests 02:36:15 INFO - Running setup.py install for docopt 02:36:16 INFO - Successfully installed blobuploader requests docopt 02:36:16 INFO - Cleaning up... 02:36:16 INFO - Return code: 0 02:36:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:16 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')]} 02:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:16 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')]} 02:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:16 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 0x7f57aa31bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b790>, '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 0x293c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293cb20>, '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': '0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756', '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 02:36:16 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 02:36:16 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 02:36:16 INFO - Using env: {'DISPLAY': ':0', 02:36:16 INFO - 'HOME': '/home/cltbld', 02:36:16 INFO - 'LANG': 'en_US.UTF-8', 02:36:16 INFO - 'LANGUAGE': 'en_US:en', 02:36:16 INFO - 'LOGNAME': 'cltbld', 02:36:16 INFO - 'MAIL': '/var/mail/cltbld', 02:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:16 INFO - 'MOZ_NO_REMOTE': '1', 02:36:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:16 INFO - 'NO_EM_RESTART': '1', 02:36:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:16 INFO - 'PWD': '/builds/slave/test', 02:36:16 INFO - 'SHELL': '/bin/bash', 02:36:16 INFO - 'SHLVL': '1', 02:36:16 INFO - 'TERM': 'linux', 02:36:16 INFO - 'TMOUT': '86400', 02:36:16 INFO - 'USER': 'cltbld', 02:36:16 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756', 02:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:16 INFO - '_': '/tools/buildbot/bin/python'} 02:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:36:16 INFO - Running setup.py (path:/tmp/pip-PW32cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:36:16 INFO - Running setup.py (path:/tmp/pip-I8g3WD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:36:16 INFO - Running setup.py (path:/tmp/pip-xzIc4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:36:16 INFO - Running setup.py (path:/tmp/pip-YN2RP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:36:16 INFO - Running setup.py (path:/tmp/pip-_Cgsmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:36:16 INFO - Running setup.py (path:/tmp/pip-GREIVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:36:16 INFO - Running setup.py (path:/tmp/pip-XnnJME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:36:16 INFO - Running setup.py (path:/tmp/pip-trn8lU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:36:16 INFO - Running setup.py (path:/tmp/pip-Qg6bjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:36:16 INFO - Running setup.py (path:/tmp/pip-RJPKg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:36:17 INFO - Running setup.py (path:/tmp/pip-7n9qEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:36:17 INFO - Running setup.py (path:/tmp/pip-bSCPjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:36:17 INFO - Running setup.py (path:/tmp/pip-bEp7ZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:36:17 INFO - Running setup.py (path:/tmp/pip-2suS4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:17 INFO - Running setup.py (path:/tmp/pip-t_jiEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:36:17 INFO - Running setup.py (path:/tmp/pip-Vjw9xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:36:17 INFO - Running setup.py (path:/tmp/pip-OzrbcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:36:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:36:17 INFO - Running setup.py install for manifestparser 02:36:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:36:17 INFO - Running setup.py install for mozcrash 02:36:17 INFO - Running setup.py install for mozdebug 02:36:17 INFO - Running setup.py install for mozdevice 02:36:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:36:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:36:17 INFO - Running setup.py install for mozfile 02:36:18 INFO - Running setup.py install for mozhttpd 02:36:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Running setup.py install for mozinfo 02:36:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Running setup.py install for mozInstall 02:36:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Running setup.py install for mozleak 02:36:18 INFO - Running setup.py install for mozlog 02:36:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Running setup.py install for moznetwork 02:36:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Running setup.py install for mozprocess 02:36:18 INFO - Running setup.py install for mozprofile 02:36:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Running setup.py install for mozrunner 02:36:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:36:19 INFO - Running setup.py install for mozscreenshot 02:36:19 INFO - Running setup.py install for moztest 02:36:19 INFO - Running setup.py install for mozversion 02:36:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:36:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:36:19 INFO - Cleaning up... 02:36:19 INFO - Return code: 0 02:36:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:19 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')]} 02:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:19 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')]} 02:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:19 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 0x7f57aa31bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b790>, '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 0x293c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293cb20>, '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': '0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756', '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 02:36:19 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 02:36:19 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 02:36:19 INFO - Using env: {'DISPLAY': ':0', 02:36:19 INFO - 'HOME': '/home/cltbld', 02:36:19 INFO - 'LANG': 'en_US.UTF-8', 02:36:19 INFO - 'LANGUAGE': 'en_US:en', 02:36:19 INFO - 'LOGNAME': 'cltbld', 02:36:19 INFO - 'MAIL': '/var/mail/cltbld', 02:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:19 INFO - 'MOZ_NO_REMOTE': '1', 02:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:19 INFO - 'NO_EM_RESTART': '1', 02:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:19 INFO - 'PWD': '/builds/slave/test', 02:36:19 INFO - 'SHELL': '/bin/bash', 02:36:19 INFO - 'SHLVL': '1', 02:36:19 INFO - 'TERM': 'linux', 02:36:19 INFO - 'TMOUT': '86400', 02:36:19 INFO - 'USER': 'cltbld', 02:36:19 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756', 02:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:19 INFO - '_': '/tools/buildbot/bin/python'} 02:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:36:19 INFO - Running setup.py (path:/tmp/pip-VYfGU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:36:19 INFO - Running setup.py (path:/tmp/pip-pI23De-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:36:19 INFO - Running setup.py (path:/tmp/pip-6yKmVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:36:19 INFO - Running setup.py (path:/tmp/pip-B7OdOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:36:19 INFO - Running setup.py (path:/tmp/pip-unnzCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:36:19 INFO - Running setup.py (path:/tmp/pip-NCRhWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:36:20 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)) 02:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:36:20 INFO - Running setup.py (path:/tmp/pip-h4MD3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:36:20 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)) 02:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:36:20 INFO - Running setup.py (path:/tmp/pip-HHLAzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:36:20 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)) 02:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:36:20 INFO - Running setup.py (path:/tmp/pip-p4athk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:36:20 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)) 02:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:36:20 INFO - Running setup.py (path:/tmp/pip-jj9quZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:36:20 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)) 02:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:36:20 INFO - Running setup.py (path:/tmp/pip-Z_3xjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:36:20 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)) 02:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:36:20 INFO - Running setup.py (path:/tmp/pip-_dp015-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:36:20 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)) 02:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:36:20 INFO - Running setup.py (path:/tmp/pip-ctE1c8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:36:20 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)) 02:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:36:20 INFO - Running setup.py (path:/tmp/pip-F8evBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:36:20 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)) 02:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:20 INFO - Running setup.py (path:/tmp/pip-yj3My6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:20 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)) 02:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:36:20 INFO - Running setup.py (path:/tmp/pip-wcrzfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:36:20 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)) 02:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:36:20 INFO - Running setup.py (path:/tmp/pip-f42HXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:36:20 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)) 02:36:20 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)) 02:36:20 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)) 02:36:20 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)) 02:36:20 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)) 02:36:20 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)) 02:36:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:36:20 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 02:36:20 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 02:36:20 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 02:36:20 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 02:36:20 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 02:36:20 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 02:36:22 INFO - Downloading blessings-1.6.tar.gz 02:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:36:22 INFO - Installing collected packages: blessings 02:36:22 INFO - Running setup.py install for blessings 02:36:22 INFO - Successfully installed blessings 02:36:22 INFO - Cleaning up... 02:36:23 INFO - Return code: 0 02:36:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:36:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:36:23 INFO - Reading from file tmpfile_stdout 02:36:23 INFO - Current package versions: 02:36:23 INFO - argparse == 1.2.1 02:36:23 INFO - blessings == 1.6 02:36:23 INFO - blobuploader == 1.2.4 02:36:23 INFO - docopt == 0.6.1 02:36:23 INFO - functools32 == 3.2.3-2 02:36:23 INFO - jsonschema == 2.5.1 02:36:23 INFO - manifestparser == 1.1 02:36:23 INFO - mozInstall == 1.12 02:36:23 INFO - mozcrash == 0.17 02:36:23 INFO - mozdebug == 0.1 02:36:23 INFO - mozdevice == 0.48 02:36:23 INFO - mozfile == 1.2 02:36:23 INFO - mozhttpd == 0.7 02:36:23 INFO - mozinfo == 0.9 02:36:23 INFO - mozleak == 0.1 02:36:23 INFO - mozlog == 3.4 02:36:23 INFO - moznetwork == 0.27 02:36:23 INFO - mozprocess == 0.23 02:36:23 INFO - mozprofile == 0.28 02:36:23 INFO - mozrunner == 6.12 02:36:23 INFO - mozscreenshot == 0.1 02:36:23 INFO - mozsystemmonitor == 0.3 02:36:23 INFO - moztest == 0.7 02:36:23 INFO - mozversion == 1.4 02:36:23 INFO - psutil == 3.1.1 02:36:23 INFO - requests == 1.2.3 02:36:23 INFO - wsgiref == 0.1.2 02:36:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:23 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')]} 02:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:23 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')]} 02:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:23 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 0x7f57aa31bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b790>, '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 0x293c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293cb20>, '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': '0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756', '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 02:36:23 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 02:36:23 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 02:36:23 INFO - Using env: {'DISPLAY': ':0', 02:36:23 INFO - 'HOME': '/home/cltbld', 02:36:23 INFO - 'LANG': 'en_US.UTF-8', 02:36:23 INFO - 'LANGUAGE': 'en_US:en', 02:36:23 INFO - 'LOGNAME': 'cltbld', 02:36:23 INFO - 'MAIL': '/var/mail/cltbld', 02:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:23 INFO - 'MOZ_NO_REMOTE': '1', 02:36:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:23 INFO - 'NO_EM_RESTART': '1', 02:36:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:23 INFO - 'PWD': '/builds/slave/test', 02:36:23 INFO - 'SHELL': '/bin/bash', 02:36:23 INFO - 'SHLVL': '1', 02:36:23 INFO - 'TERM': 'linux', 02:36:23 INFO - 'TMOUT': '86400', 02:36:23 INFO - 'USER': 'cltbld', 02:36:23 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756', 02:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:23 INFO - '_': '/tools/buildbot/bin/python'} 02:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 INFO - Cleaning up... 02:36:23 INFO - Return code: 0 02:36:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:36:23 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')]} 02:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:23 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')]} 02:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:23 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 0x7f57aa31bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b790>, '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 0x293c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293cb20>, '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': '0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756', '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 02:36:23 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 02:36:23 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 02:36:23 INFO - Using env: {'DISPLAY': ':0', 02:36:23 INFO - 'HOME': '/home/cltbld', 02:36:23 INFO - 'LANG': 'en_US.UTF-8', 02:36:23 INFO - 'LANGUAGE': 'en_US:en', 02:36:23 INFO - 'LOGNAME': 'cltbld', 02:36:23 INFO - 'MAIL': '/var/mail/cltbld', 02:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:23 INFO - 'MOZ_NO_REMOTE': '1', 02:36:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:23 INFO - 'NO_EM_RESTART': '1', 02:36:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:23 INFO - 'PWD': '/builds/slave/test', 02:36:23 INFO - 'SHELL': '/bin/bash', 02:36:23 INFO - 'SHLVL': '1', 02:36:23 INFO - 'TERM': 'linux', 02:36:23 INFO - 'TMOUT': '86400', 02:36:23 INFO - 'USER': 'cltbld', 02:36:23 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756', 02:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:23 INFO - '_': '/tools/buildbot/bin/python'} 02:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:36:23 INFO - Cleaning up... 02:36:23 INFO - Return code: 0 02:36:23 INFO - Running post-action listener: _resource_record_post_action 02:36:23 INFO - Running post-action listener: _start_resource_monitoring 02:36:23 INFO - Starting resource monitoring. 02:36:23 INFO - [mozharness: 2016-10-13 09:36:23.739321Z] Finished create-virtualenv step (success) 02:36:23 INFO - [mozharness: 2016-10-13 09:36:23.739830Z] Running install step. 02:36:23 INFO - Running pre-action listener: _resource_record_pre_action 02:36:23 INFO - Running main action method: install 02:36:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:36:23 INFO - Reading from file tmpfile_stdout 02:36:23 INFO - Detecting whether we're running mozinstall >=1.0... 02:36:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:36:24 INFO - Reading from file tmpfile_stdout 02:36:24 INFO - Output received: 02:36:24 INFO - Usage: mozinstall [options] installer 02:36:24 INFO - Options: 02:36:24 INFO - -h, --help show this help message and exit 02:36:24 INFO - -d DEST, --destination=DEST 02:36:24 INFO - Directory to install application into. [default: 02:36:24 INFO - "/builds/slave/test"] 02:36:24 INFO - --app=APP Application being installed. [default: firefox] 02:36:24 INFO - mkdir: /builds/slave/test/build/application 02:36:24 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'] 02:36:24 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 02:36:41 INFO - Reading from file tmpfile_stdout 02:36:41 INFO - Output received: 02:36:41 INFO - /builds/slave/test/build/application/firefox/firefox 02:36:41 INFO - Running post-action listener: _resource_record_post_action 02:36:41 INFO - [mozharness: 2016-10-13 09:36:41.113228Z] Finished install step (success) 02:36:41 INFO - [mozharness: 2016-10-13 09:36:41.113537Z] Running run-tests step. 02:36:41 INFO - Running pre-action listener: _resource_record_pre_action 02:36:41 INFO - Running main action method: run_tests 02:36:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:36:41 INFO - Python 2.7.3 02:36:41 INFO - Return code: 0 02:36:41 INFO - grabbing minidump binary from tooltool 02:36:41 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')]} 02:36:41 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 0x293b790>, '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 0x293c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:36:41 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 02:36:41 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 02:36:41 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 02:36:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:36:41 INFO - Return code: 0 02:36:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:36:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:36:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:36:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:36:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:36:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 02:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 02:36:41 INFO - Using env: {'DISPLAY': ':0', 02:36:41 INFO - 'HOME': '/home/cltbld', 02:36:41 INFO - 'LANG': 'en_US.UTF-8', 02:36:41 INFO - 'LANGUAGE': 'en_US:en', 02:36:41 INFO - 'LOGNAME': 'cltbld', 02:36:41 INFO - 'MAIL': '/var/mail/cltbld', 02:36:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:36:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:36:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:41 INFO - 'MOZ_NO_REMOTE': '1', 02:36:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:36:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:41 INFO - 'NO_EM_RESTART': '1', 02:36:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:41 INFO - 'PWD': '/builds/slave/test', 02:36:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:36:41 INFO - 'SHELL': '/bin/bash', 02:36:41 INFO - 'SHLVL': '1', 02:36:41 INFO - 'TERM': 'linux', 02:36:41 INFO - 'TMOUT': '86400', 02:36:41 INFO - 'USER': 'cltbld', 02:36:41 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756', 02:36:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:41 INFO - '_': '/tools/buildbot/bin/python'} 02:36:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 02:36:41 INFO - mozversion application_buildid: 20161012233221 02:36:41 INFO - mozversion application_changeset: 68be448035953cf34c99cc642374ea54754c86e2 02:36:41 INFO - mozversion application_display_name: Nightly 02:36:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:36:41 INFO - mozversion application_name: Firefox 02:36:41 INFO - mozversion application_remotingname: firefox 02:36:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 02:36:41 INFO - mozversion application_vendor: Mozilla 02:36:41 INFO - mozversion application_version: 52.0a1 02:36:41 INFO - mozversion platform_buildid: 20161012233221 02:36:41 INFO - mozversion platform_changeset: 68be448035953cf34c99cc642374ea54754c86e2 02:36:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 02:36:41 INFO - mozversion platform_version: 52.0a1 02:36:41 INFO - using testdate: 1476351401 02:36:41 INFO - actual date: 1476351401 02:36:41 INFO - starting webserver on 'localhost:57069' 02:36:41 INFO - SUITE-START | Running 2 tests 02:36:41 INFO - TEST-START | dromaeo_css 02:36:41 INFO - operating with platform_type : linux_ 02:36:41 INFO - Initialising browser for dromaeo_css test... 02:36:41 INFO - TEST-INFO | started process 14731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFlI4zJ/profile http://localhost:57069/getInfo.html) 02:36:45 INFO - PROCESS | 14731 | __metrics Screen width/height:1600/1200 02:36:45 INFO - PROCESS | 14731 | colorDepth:24 02:36:45 INFO - PROCESS | 14731 | Browser inner width/height: 1024/697 02:36:45 INFO - PROCESS | 14731 | __metrics 02:36:45 INFO - PROCESS | 14731 | 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" 02:36:45 INFO - PROCESS | 14731 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:36:46 INFO - PROCESS | 14731 | console.error: PushService: 02:36:46 INFO - PROCESS | 14731 | stateChangeProcessEnqueue: Error transitioning state 02:36:46 INFO - PROCESS | 14731 | UnknownError 02:36:46 INFO - TEST-INFO | 14731: exit 0 02:36:46 INFO - Browser initialized. 02:36:46 INFO - Running cycle 1/1 for dromaeo_css test... 02:36:46 INFO - TEST-INFO | started process 14814 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFlI4zJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:36:58 INFO - PROCESS | 14814 | RSS: Main: 173457408 02:36:58 INFO - PROCESS | 14814 | 02:37:50 INFO - PROCESS | 14814 | 1476351470289 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] 02:39:59 INFO - PROCESS | 14814 | Cycle 1(1): loaded http://localhost:57069/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57069/tests/dromaeo/cssquery-ext.html) 02:40:02 INFO - PROCESS | 14814 | RSS: Main: 381841408 02:40:02 INFO - PROCESS | 14814 | 02:43:04 INFO - PROCESS | 14814 | Cycle 1(1): loaded http://localhost:57069/tests/dromaeo/cssquery-ext.html (next: http://localhost:57069/tests/dromaeo/cssquery-jquery.html) 02:43:05 INFO - PROCESS | 14814 | RSS: Main: 281780224 02:43:05 INFO - PROCESS | 14814 | 02:46:07 INFO - PROCESS | 14814 | Cycle 1(1): loaded http://localhost:57069/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57069/tests/dromaeo/cssquery-mootools.html) 02:46:08 INFO - PROCESS | 14814 | RSS: Main: 221057024 02:46:08 INFO - PROCESS | 14814 | 02:49:10 INFO - PROCESS | 14814 | Cycle 1(1): loaded http://localhost:57069/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57069/tests/dromaeo/cssquery-prototype.html) 02:49:10 INFO - PROCESS | 14814 | RSS: Main: 216825856 02:49:10 INFO - PROCESS | 14814 | 02:52:13 INFO - PROCESS | 14814 | Cycle 1(1): loaded http://localhost:57069/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57069/tests/dromaeo/cssquery-yui.html) 02:52:14 INFO - PROCESS | 14814 | RSS: Main: 218927104 02:52:14 INFO - PROCESS | 14814 | 02:55:17 INFO - PROCESS | 14814 | Cycle 1(1): loaded http://localhost:57069/tests/dromaeo/cssquery-yui.html (next: http://localhost:57069/tests/dromaeo/cssquery-dojo.html) 02:55:17 INFO - PROCESS | 14814 | RSS: Main: 310501376 02:55:17 INFO - PROCESS | 14814 | 02:55:17 INFO - PROCESS | 14814 | __start_tp_report 02:55:17 INFO - PROCESS | 14814 | _x_x_mozilla_page_load 02:55:17 INFO - PROCESS | 14814 | _x_x_mozilla_page_load_details 02:55:17 INFO - PROCESS | 14814 | |i|pagename|runs| 02:55:17 INFO - PROCESS | 14814 | |0;dojo.html;3010.6236720409947;3028.061300996691;3032.848357582121;3072.1551573317347;3087.907362779116;5053.039922414748;5126.897462050757;5137.332146820912;5206.167013277876;5254.316938797951;5138.511841375063;5214.322138122048;5320.494553017457;5329;5340.519353258206;4584.862454126382;4589.196890544158;4643.466001409831;4668.323093151491;4671.135839869618;4190.643795277405;4727.5272472752795;4786.2581299898575;4798.688085274446;4848.733319667417;4678.836240731558;4691.179043667345;4723.858284251478;4733.431988161408;4771.284307353907;4588.082383523275;4627.768611569408;4630.3748993886065;4673.953260467386;4712.787924543404;4668.509806470306;4671.5795578397765;4683.648726345537;4733.171694953369;4741.217699079648;5220.686758794484;5238.659487133325;5243.973780131075;5244.265802787613;5280.973595132038;5353.491418315254;5415.675059496442;5491.258680078178;5623.634463759842;5628.296462942132;5525.143602741541;5595.692236926968;5612.775488980476;5622.1004639257935;5684.34630017545;5240.633155679104;5240.9213861792105;5245.947540524546;5250.7637156328055;5251.973740131351;5573.191887176336;5628.324601047901;5703.600747947687;5703.62926409782;5766.135079738073;5281.524662780368;5305.522502974751;5382.273393091961;5383.569314454834;5438.809641662523;5349.81275655358;5359.954808812322;5393.649412788156;5443.401225865152;5447.618666693294;5366.148480615043;5422.349318081855;5423.891522169534;5431.293931788842;5485.862853428696;5302.549283310885;5352.705601191972;5422.5119739223655;5532.944670553324;5537.529310008614;4309.504406993173;4333.501647310537;4336;4336.046069864625;4388.978055109704;3853.7109716771356;3867.5939026402384;3882.1265215326325;3903.1998440319667;3908;5065.214891691794;5117.283580298761;5183.559397451183;5249.186376111708;5251.579873610102;5623.268975033219;5628.577856660685;5629.24005259293;5633.352164501053;5646.774129034792;5248.895022099613;5255.3168088148295;5257.553107985864;5259.894802103937;5323.520883120537;4751.596114330251;4760.285957106462;4791.736454494967;4834.371531700926;4844.2007068833955;5668.376478587352;5751.683657398883;5754.9424505754405;5809.88380232393;5815.273090863727;5537.141743029837;5544.3346798384455;5557.277553917965;5558.72206389687;5568.49883510486;5660.405657406078;5700.458456446631;5731.627444216113;5731.7420716067045;5748.252727145445;5513.696746678971;5530.364008139116;5536.501714845684;5538;5538.086215774352;5594.300712410949;5600.943990560042;5607.747651355618;5608.074667679787;5616.045272303636;5472.50747432733;5480.451954804487;5481.643693159932;5492.47821456961;5493.09363954943;5444.156155795699;5475.206095116107;5487.862803429946;5514.255575497256;5523.337199536081;5360.812371566976;5378.435264297349;5380.757865895966;5381.48875856793;5387.164989426645;5368.677879327252;5390.757415916215;5465.262189604353;5466.098093814476;5479;5331.093714068696;5334.279872217201;5334.973325133349;5336;5342.679439233503 02:55:17 INFO - PROCESS | 14814 | |1;ext.html;578.7164289498145;583.2068386993687;598.2671227746009;599.7541008186645;604.5224272824472;42476.36285455717;44024.559754402486;44447.77776111123;48205.7589712051;48225.517744822544;45867.77066114665;46254;46393.76803115988;46409.7679511602;46431.76784116075;7938.24586664266;8866.335024873128;9003;9011.459312441242;9023.503707296097;8035.598220089001;8332.70835520757;8344.08215096339;10473.947630261877;10744.247902646817;10900.836487452694;11041.061509771678;11041.779164416746;11048.226624136314;11054.447277636125;10801.135909127252;10869.293495922779;10883.67348979532;10885.183611229111;10887.673369798918;10560.155187585051;10589.258751887372;10596.099331556827;10660.307080039851;10668.039876411083;42097.57902420967;42415.1516969662;42498.36252456216;42655.786721066506;42767.144657106684;3499.475078738184;3671.3575124353133;4040.636342729139;4079.9796001019804;4115.938260926088;32038.83980580082;32250.51624225615;32428.675713243036;33163;33221.33557328864;4308.332208507655;4329.177456283296;4345.109252603241;4444.844430444951;4593.5406459354135;324694;324704;329836;330902.9999999976;331014;34590;59413.405865941655;60003.499912502535;60082.39917600768;60096.699516502136;37967.24065518729;38020.429693554615;38135;38181.23637527234;38184;14362.569122926328;14439.278036098152;14444.061136026125;14470.638234044232;14485.92757036208;11895.881041189477;13388.263645499395;13442;13474;13492.257925814174;8007.359411247086;8502.617382217815;8658.350623703247;8752.8687069694;8878.511681857432;3351.145457908218;3355.6644335566248;3386.5258863759095;3406.863725450954;3408.2161102945965;1024.2318261304022;1031.4120951057826;1037.2376303416982;1037.4138611684375;1095.0691911874842;31746.841265793522;31926;32051;32690.836545817117;32841;1070.1438848920832;1100.389283947417;1114.8606424196976;1135.0238794636605;1178.505027888289;16170.514884553248;16714.498565043068;16799.91600041992;16833.41083062087;17097.658046839242;494712;496819;498828;499725;502314;56984.715076424356;57246.713766431734;57338.7133064332;57412.13881791777;57503.424965750644;1169.2984209474419;1221.7861874171983;1290.8709129087017;1295.799151131576;1299.5581502289267;29053.564196536645;33047.390521896195;33217.66782332242;33351;33521;53602.19596705974;55383;55430;61503;61543.38456615376;474429;478758;479015;479318;479455;28134.43731125407;28216;28453;30618.693813061585;43381.40825355487;46279.53720462752;46611.300830488246;46739.766301169635;46936.7653161732;47135.292970606155;39411.60588394194;40798.59201407948;41051.58948410597;41292;42234.78882605567;40420.79789601033;40482.534857795;41476.58523414727;41589.58410415857;41773.6009397883;40421.797891010356;40901.79549102354;41371.1725765489;43926;44014.779926100164;34359;36864.81567592145;37282.25435491329;37340.813295933345;37418.812905935294;27652.861735691193;28111.43777124405;28315.292117697223;28408;28480.572791407732 02:55:17 INFO - PROCESS | 14814 | |2;jquery.html;376.6572419098621;392.26058879013067;403.7173978215248;406.1329062451665;419.9895002624934;13711.314434278296;15290.235488225586;18722.812771872294;19011.429657110308;19399.515012124702;18177.727334089966;18219.36232231872;18339.08304584772;18675.719864202012;18738.96935668538;5285.312909321783;5465.289512363387;5702.800401985931;5709.8572535686735;5711.600187986843;5335.226392173133;5668.404817494165;5689.345725241588;5693.487586117249;5694.174344720013;5468.91796623051;5660.9433905661035;5662.5753068520025;5666.716664166795;5669.574781891354;5721.199032135483;5853.356130825606;5897.675627840467;5903.026000709878;5907.586468947154;5576.442355764431;5712.771489140429;5720.713964301768;5740.110282906115;5748;13957.860421395757;14187.219702916336;14196.432142714279;16310.592235194097;21811.563768724696;2119.724435823333;2260.8417410781253;2292.33522278539;2305.5965206088867;2509.6794795034643;10105.242106842017;10142.89857101427;10337.37975721459;10693.251472396858;10728.409937453436;1879.7274395212755;1904.9047547622702;1907.3419670213755;1926.5761532462836;1939.8739081959768;84781;86121.56939215264;86586;87002;87515;10750.463511291691;11009;11046.33721976684;11065;11149.331040137455;15772.211389430482;15824.129672868103;15829.525114246591;15846.920765396098;15851.682966340608;7562.2437756223935;7815.218478152253;7942.722004729807;8040.195980401913;8134.502164069507;7453.515521491194;7504.287092726182;7657.57883316423;7770.0675918888965;7799.454038217384;4592.563706447882;4711.884901422036;4716.528347165256;4750.596199323028;4854.854354369375;1951.7462729845313;1967.1672791180654;1973.575681228514;1986.3742920979846;2014.5769388428594;820.2986446588201;902.354816306331;926.5321012888448;948.7580666930027;997.8004399120205;16749.91625041867;16990.150492475328;17460.738088928676;17870.91064544669;18313.7252941206;869.1786261982493;907.1065000974036;914.2685851318919;936.7564433247269;964.5370222293338;10043.296969212231;10071.59713611462;10099.394036357842;10181.796364072678;10194.898051019394;328356;332877;332964;451124;451206;56819.715901420226;59665.40334596685;70015.94976075363;83896.73755461586;99349;991.6578780320777;1012.6152062216311;1040.5057597641212;1043.0768769638773;1048.9003544663244;16753.74869376936;16969.490915272563;17729.290828367237;17952.678998565072;17986.910065450113;41734.58265417307;42191.789041055825;42440.575594244896;43821.561784381745;44998.77500612607;61153.38846611477;61234.38765612287;62357;62776.68611656912;63075.6846215766;8534.487930724177;8552.401331906707;8710.564471776512;8839.734807955772;8910.55447227649;12045.75908481843;12419.875801241871;13062.738745224851;13079.280639564915;13238.801417978546;5889.087191485327;8782.91217087821;10626.256162068581;10787;11960.940195298968;10737.785244294913;10839.891601083888;10992.17558683118;11521.654350369503;12028.338441385458;11298.209125361145;11504.597339093092;11545.422728863356;11555.191136620357;11957.760844782882;8574.52840093776;8654.524001179996;8675.089115642766;8803.075677053817;8916.592520019429;10609.681709548726;11018.559257629926;11642.53429862796;11707.531698731955;12002.099842512021 02:55:17 INFO - PROCESS | 14814 | |3;mootools.html;1332.3671256153323;1442.632128807154;1485.9851401485985;1582.6122599963012;1730.5846596816768;7429.62851857407;8207.794805129868;8432.873506897393;8461.619227134779;8720.040795512488;8598.44110132841;8651.610677519511;8673.349498787584;8673.609687564074;8675.26260267878;2264.1735766445213;2302.7466978632337;2304.6427803690453;2307.861528308307;2310.9075636974585;2226.3209721035078;2259.3109101723967;2316.8494047886834;2321.802646775026;2322.3381336319153;2253.5943530164564;2264.9660255096187;2280.2019293247313;2286.336962280945;2301.5281867217263;2239.8432109752325;2245.0346351069034;2247.2696373678536;2263.5359751250953;2265.728112626487;2189.9890500547554;2201.757806641268;2208.3595757230382;2213.5904857601395;2222.4443889027743;8572.185642364027;8654.956725216396;8659;8746.431481953652;8865.822683546294;5020.397552293712;5186.662866913639;5187.922181167285;5201.9479805201845;5230.712310822903;3216.8391580420885;3368.8147151906637;3437.3812713711523;3450.6204317525053;3453.1021934297264;1173.5423184957874;1217.31221859649;1219.71336735867;1220.4263995921901;2119.4807272218404;11723.120765942589;12116.636500904988;12119.575814846437;12124.939375303155;12159.392030398445;4393.450818647669;4448.110377924428;4465.330200469891;4585.358049873021;4736.123817093849;9583.041695830361;9618.759531011781;9671.081247281498;9679.37084089546;9693.806123877483;5020.1214787412055;5021.221710634857;5022.799088036438;5025;5026.472220416877;4181.707280490336;4301.204277208726;4615.630749540029;4686.109639168615;4718.245080787057;3597.6222496638;3635.563732352082;3651;3663.6519530644546;3702;1118.8364101334685;1128.610629332879;1135.392564977733;1135.6990397544657;1139.5783560082657;776.0609662308669;859.9914000860036;898.8067565473324;943.528235882059;953.68051702679;5807.970960145172;5840.620359676607;5869.413058694096;5963.373845746221;6075.787347442818;916.5508900638639;920.963161473547;944.5182956691999;945.716285114463;998.5356809083811;3946.8026598669953;4039.1517781265675;4040.8585699500964;4067.8576249831112;4138.91722165561;10387.584496620202;10697.625583104555;10713.517891694892;10715;10729.517171727291;10618.681439556825;10647.201459890539;10648.78702425947;10678.786424271471;10708.625198118028;8081.555514446762;8180.7954801130445;8207.95896020516;8208;8222.054463736627;5676.914846277392;5737.885242295214;5784.942150578609;5889.087191485327;5984.102384642339;10021.899781002388;10099.798004040025;10106.242031847787;10146.898531014594;10200.285979981627;9081.228095611683;9363.29775266844;9393.342466027585;9533.427994320364;9545.427274363283;6870.553414028072;7112.466565007541;7592.126905405949;7640;7870.29167374939;8252;8642.567871606268;8645.135486451305;8648.43785153963;8648.870266946127;7324.743633972786;7449.925500744923;7504.512206706547;7606.429517786299;7672.117706463828;7252.456065795192;7300.415966722756;7450.739224127129;7534;7656.846863062596;6934.895976560457;6934.965325173342;6937.340952609494;6949.791506254821;6950.061741665013;4829.903401932012;4897.436794768647;4915.901681966412;4932.506749325183;4971.37857767779;5042.949570504248;5096.210087436453;5141.845744627667;5273.2090186470805;5306.761195746123 02:55:17 INFO - PROCESS | 14814 | |4;prototype.html;336.39113205098766;342.60771416727846;347.41807472483583;348.92846966371894;349.1550447916046;5242.501962313579;5254.737263136837;5264.684118952866;5284.4187139414635;5325.387580428247;5195.03891780021;5212.76542555585;5230.712310822903;5234.816781412651;5238.7642556084975;3828.942565861514;3917.7649341039487;3963.6829053675638;4011.699122565805;4058;4065.837366505351;4071.5928407159195;4102.753834769924;4113.25961326961;4121.629053385194;3989.321815291393;4017.9799101004455;4028.96537248689;4037.7173597848164;4042.2117687051036;3797.8670746524017;3832.923341533168;3966.86115985942;4000.3599424092295;4052.9189416211807;3589.569251689788;3592.281543691246;3592.6227746086547;3603.40543810271;3623.0942264433893;5023.6985780853265;5024.773885175176;5029.497050294978;5034.421041580228;5069.1129052416045;4570.337301091323;4618.838340658061;4658.510856360067;4676.485586585472;4716.198246298138;5363.946360536423;5382.973085134549;5386.380566234894;5389.703566303851;5416.566674666017;4015.4779878615886;4025.1547175092974;4029.959700403017;4039.8586049488126;4050.5949405059555;5482.725863706799;5525.64083334586;5559.249501317311;5587.776488940438;5664.122061080539;4089.44792453021;4093.7953102344763;4094.6519545838937;4098.344264917599;4114.218298523331;4086.693497987663;4138.337865941435;4156.210320039183;4160.1471698301775;4168.937465938014;4364.650827933758;4560.931586026212;4638.489766125724;4646.372739680168;4651.5813576778255;5399.163129714901;5407.810726624549;5418.83743487696;5419.458054194628;5446.945530544644;1387.555982085723;1398.321813920248;1403.5122769863772;1408.9225092620004;1414.4342263094638;848.9320854331638;908.8682141089505;914.3964983111115;920.5397301349325;934.8550974598948;5003.749812509433;5066.98514383941;5068.315777370081;5122.231665250242;5143.71709555978;5415.48552887475;5419.214213938957;5427.255193916264;5532.944670553324;5574.442555744393;4995.500449955048;5136.794528218904;5149.9742501287255;5180.274761533388;5243.318368612056;2852.971470285312;2926.809757365764;2928.546075358323;2941.0882926098207;2975.1851370663876;5711.257536520226;5716.256886604715;5765.654060756284;5768.740406681625;5784.768609255582;5507.237683941181;5597.944020559824;5602.971985140048;5624.775008999676;5711.914321285184;5647.858803529944;5661.518770904519;5676.205331253628;5705.5150312223095;5706.9429305707245;5375;5494.890102197854;5536.501714845684;5548.667079975215;5598.440155984532;5426.158945363475;5458.344998600193;5465.426130256425;5468.179773034077;5473.31583552056;5685.545156387562;5706.343770466449;5709.371969083314;5724.542036637143;5748.885022299447;3687.6128006558924;3710.4990826238113;3738.9904725724446;3749.831257593469;3886.825092870771;5517.806876759294;5534.391216966211;5540.7783688652;5551.278333816578;5554.472325129106;5422.810201642924;5442.510174084351;5451.918221226605;5517.531009864046;5528.391876893619;5287.471252874681;5351.491608297206;5418.024755543882;5484.451554844483;5502.504774570148;5315.521603055744;5317.920231196458;5330.173823057432;5344.4922732340365;5344.866378340417;5192.896142077062;5373.35519737634;5374.441411990479;5436.939796739598;5457.181422786455;5359.437259087739;5367.5169234769055;5385.8114965976;5388.137897936312;5393.352797664305 02:55:17 INFO - PROCESS | 14814 | |5;yui.html;741.2032065529556;750.523417629805;773.9806504837378;783.1346362269692;829.1873963515758;13447.731045379087;13908.026438149322;13915.512957046505;13922.095063820845;13928.51250206243;13776.24230667313;13799.517016904385;13812.585622431317;13828.308584570756;13871.653208669763;657.1227411405755;774.2025713515088;799.8240387114826;801.7033697531922;802.4262652203673;676.5399528320739;779.3375630713876;795.4908858330673;804.9678012879477;807.5235610989515;841.364769598952;843.4517563583659;844.012505368717;845.7800971747359;846.0143932318872;670.4502308107354;820.327331588098;827.3670641958906;839.7019058234331;840.6175190288435;501.21809976436873;586.3755100817616;600.2376981233853;602.6655206360468;606.0152252589542;13570.525031623845;13696.863031369758;13712.108712933627;13740.725185496234;13769.655758606015;12538.373081345897;12715.300658463873;13999.790003149961;14277.857221427757;14322.483270112178;13217.933910330483;13374.531891383755;13513.418943979854;13577.52478663242;13592.25242611656;3871.593482684306;3925.3523168677134;4421.801018954123;4491.438570178728;4565.680402371835;65406.67296663486;75577.62211188964;76023;76087.6195619024;76202.99999999945;11245.718857028476;11455.656330310105;11486.540538378538;11500.827487587692;11548.826767598493;22472.662910056362;22558.661620075713;22798.430039249153;22878.65682014771;22887.542249154925;8598.699045533376;8604.35467339952;8629.61166747498;8709.129087091367;8995.595198216097;4846.660733748604;4927.531884470969;4947.5794557462295;4977.502249774993;5113.565346945551;3630.673239408466;3667.94498082529;3694.7783133011567;3715.888523344304;3729.9813500932323;671.0739179931663;674.2919934069208;681.8397676546008;688.3357559954668;689.2934741889603;709.1879797631683;714.1073657927591;715.1418298042266;718.558086776639;737.5943231222806;9684.95157524208;9925.553350099262;10282.845757313646;10318.226133040052;10381.169506439466;741.5847125609675;753.179034852014;763.6029264782283;784.1648644193915;787.6219414680985;4439.600435960779;4878.707277563287;4948.059868625021;4979.253112033151;4993.300937868701;75034.6248268766;91153.54423227841;92382;94422;108686.45656771665;88735.55632221927;90682;91450;92265.53867230755;93100;80643.59678201571;80721;84042.57978710068;84676;85404.14595854086;9860.506974651094;10252.333598316383;10447.477626118512;10538.841917371092;10577.894221057692;49194.26208606945;49771.50228497814;49862.252066219764;50463.49536504588;50732.239016414045;67825.66087169532;74599.62700186681;74968;75541.62229188818;76865.61567192129;13157.934210328887;13191.406386712813;13359.666008349868;13403.25757651499;13508.729825403241;13548.86451135476;14046.929765351108;14457.27713614294;14624.488142914946;15650.921745391655;14101.647458813612;14101.788473172706;14285.857141428869;14916.85083149198;15313.157776322409;13292.667683307995;13855.792163117763;14100.929495352868;14893.478728244892;15260.618484537976;13925.303734813422;14062.859371406565;14069.788953165506;14195.574132776033;14447.277636117942;11297.209195356247;11470;11558.42207889619;11688.415579220835;12208.328541929925;11846.407679616157;11990.220635658654;11997.76004479923;12182.14724969279;12359.134860559674 02:55:17 INFO - PROCESS | 14814 | __end_tp_report 02:55:17 INFO - PROCESS | 14814 | __start_cc_report 02:55:17 INFO - PROCESS | 14814 | _x_x_mozilla_cycle_collect,2596 02:55:17 INFO - PROCESS | 14814 | __end_cc_report 02:55:17 INFO - PROCESS | 14814 | __startTimestamp1476352517342__endTimestamp 02:55:17 INFO - PROCESS | 14814 | 02:55:17 INFO - PROCESS | 14814 | ------- Summary: start ------- 02:55:17 INFO - PROCESS | 14814 | Number of tests: 6 02:55:17 INFO - PROCESS | 14814 | 02:55:17 INFO - PROCESS | 14814 | [#0] dojo.html Cycles:165 Average:5154.79 Median:5342.68 stddev:574.51 (10.8%) stddev-sans-first:551.10 02:55:17 INFO - PROCESS | 14814 | Values: 3010.6 3028.1 3032.8 3072.2 3087.9 5053.0 5126.9 5137.3 5206.2 5254.3 5138.5 5214.3 5320.5 5329.0 5340.5 4584.9 4589.2 4643.5 4668.3 4671.1 4190.6 4727.5 4786.3 4798.7 4848.7 4678.8 4691.2 4723.9 4733.4 4771.3 4588.1 4627.8 4630.4 4674.0 4712.8 4668.5 4671.6 4683.6 4733.2 4741.2 5220.7 5238.7 5244.0 5244.3 5281.0 5353.5 5415.7 5491.3 5623.6 5628.3 5525.1 5595.7 5612.8 5622.1 5684.3 5240.6 5240.9 5245.9 5250.8 5252.0 5573.2 5628.3 5703.6 5703.6 5766.1 5281.5 5305.5 5382.3 5383.6 5438.8 5349.8 5360.0 5393.6 5443.4 5447.6 5366.1 5422.3 5423.9 5431.3 5485.9 5302.5 5352.7 5422.5 5532.9 5537.5 4309.5 4333.5 4336.0 4336.0 4389.0 3853.7 3867.6 3882.1 3903.2 3908.0 5065.2 5117.3 5183.6 5249.2 5251.6 5623.3 5628.6 5629.2 5633.4 5646.8 5248.9 5255.3 5257.6 5259.9 5323.5 4751.6 4760.3 4791.7 4834.4 4844.2 5668.4 5751.7 5754.9 5809.9 5815.3 5537.1 5544.3 5557.3 5558.7 5568.5 5660.4 5700.5 5731.6 5731.7 5748.3 5513.7 5530.4 5536.5 5538.0 5538.1 5594.3 5600.9 5607.7 5608.1 5616.0 5472.5 5480.5 5481.6 5492.5 5493.1 5444.2 5475.2 5487.9 5514.3 5523.3 5360.8 5378.4 5380.8 5381.5 5387.2 5368.7 5390.8 5465.3 5466.1 5479.0 5331.1 5334.3 5335.0 5336.0 5342.7 02:55:17 INFO - PROCESS | 14814 | 02:55:17 INFO - PROCESS | 14814 | [#1] ext.html Cycles:180 Average:59187.48 Median:38077.71 stddev:117105.39 (307.5%) stddev-sans-first:117351.22 02:55:17 INFO - PROCESS | 14814 | Values: 578.7 583.2 598.3 599.8 604.5 42476.4 44024.6 44447.8 48205.8 48225.5 45867.8 46254.0 46393.8 46409.8 46431.8 7938.2 8866.3 9003.0 9011.5 9023.5 8035.6 8332.7 8344.1 10473.9 10744.2 10900.8 11041.1 11041.8 11048.2 11054.4 10801.1 10869.3 10883.7 10885.2 10887.7 10560.2 10589.3 10596.1 10660.3 10668.0 42097.6 42415.2 42498.4 42655.8 42767.1 3499.5 3671.4 4040.6 4080.0 4115.9 32038.8 32250.5 32428.7 33163.0 33221.3 4308.3 4329.2 4345.1 4444.8 4593.5 324694.0 324704.0 329836.0 330903.0 331014.0 34590.0 59413.4 60003.5 60082.4 60096.7 37967.2 38020.4 38135.0 38181.2 38184.0 14362.6 14439.3 14444.1 14470.6 14485.9 11895.9 13388.3 13442.0 13474.0 13492.3 8007.4 8502.6 8658.4 8752.9 8878.5 3351.1 3355.7 3386.5 3406.9 3408.2 1024.2 1031.4 1037.2 1037.4 1095.1 31746.8 31926.0 32051.0 32690.8 32841.0 1070.1 1100.4 1114.9 1135.0 1178.5 16170.5 16714.5 16799.9 16833.4 17097.7 494712.0 496819.0 498828.0 499725.0 502314.0 56984.7 57246.7 57338.7 57412.1 57503.4 1169.3 1221.8 1290.9 1295.8 1299.6 29053.6 33047.4 33217.7 33351.0 33521.0 53602.2 55383.0 55430.0 61503.0 61543.4 474429.0 478758.0 479015.0 479318.0 479455.0 28134.4 28216.0 28453.0 30618.7 43381.4 46279.5 46611.3 46739.8 46936.8 47135.3 39411.6 40798.6 41051.6 41292.0 42234.8 40420.8 40482.5 41476.6 41589.6 41773.6 40421.8 40901.8 41371.2 43926.0 44014.8 34359.0 36864.8 37282.3 37340.8 37418.8 27652.9 28111.4 28315.3 28408.0 28480.6 02:55:17 INFO - PROCESS | 14814 | 02:55:17 INFO - PROCESS | 14814 | [#2] jquery.html Cycles:180 Average:25304.41 Median:384.46 stddev:63946.43 (16632.8%) stddev-sans-first:64098.43 02:55:17 INFO - PROCESS | 14814 | Values: 376.7 392.3 403.7 406.1 420.0 13711.3 15290.2 18722.8 19011.4 19399.5 18177.7 18219.4 18339.1 18675.7 18739.0 5285.3 5465.3 5702.8 5709.9 5711.6 5335.2 5668.4 5689.3 5693.5 5694.2 5468.9 5660.9 5662.6 5666.7 5669.6 5721.2 5853.4 5897.7 5903.0 5907.6 5576.4 5712.8 5720.7 5740.1 5748.0 13957.9 14187.2 14196.4 16310.6 21811.6 2119.7 2260.8 2292.3 2305.6 2509.7 10105.2 10142.9 10337.4 10693.3 10728.4 1879.7 1904.9 1907.3 1926.6 1939.9 84781.0 86121.6 86586.0 87002.0 87515.0 10750.5 11009.0 11046.3 11065.0 11149.3 15772.2 15824.1 15829.5 15846.9 15851.7 7562.2 7815.2 7942.7 8040.2 8134.5 7453.5 7504.3 7657.6 7770.1 7799.5 4592.6 4711.9 4716.5 4750.6 4854.9 1951.7 1967.2 1973.6 1986.4 2014.6 820.3 902.4 926.5 948.8 997.8 16749.9 16990.2 17460.7 17870.9 18313.7 869.2 907.1 914.3 936.8 964.5 10043.3 10071.6 10099.4 10181.8 10194.9 328356.0 332877.0 332964.0 451124.0 451206.0 56819.7 59665.4 70015.9 83896.7 99349.0 991.7 1012.6 1040.5 1043.1 1048.9 16753.7 16969.5 17729.3 17952.7 17986.9 41734.6 42191.8 42440.6 43821.6 44998.8 61153.4 61234.4 62357.0 62776.7 63075.7 8534.5 8552.4 8710.6 8839.7 8910.6 12045.8 12419.9 13062.7 13079.3 13238.8 5889.1 8782.9 10626.3 10787.0 11960.9 10737.8 10839.9 10992.2 11521.7 12028.3 11298.2 11504.6 11545.4 11555.2 11957.8 8574.5 8654.5 8675.1 8803.1 8916.6 10609.7 11018.6 11642.5 11707.5 12002.1 02:55:17 INFO - PROCESS | 14814 | 02:55:17 INFO - PROCESS | 14814 | [#3] mootools.html Cycles:180 Average:5651.76 Median:5020.26 stddev:3200.44 (63.8%) stddev-sans-first:3192.95 02:55:17 INFO - PROCESS | 14814 | Values: 1332.4 1442.6 1486.0 1582.6 1730.6 7429.6 8207.8 8432.9 8461.6 8720.0 8598.4 8651.6 8673.3 8673.6 8675.3 2264.2 2302.7 2304.6 2307.9 2310.9 2226.3 2259.3 2316.8 2321.8 2322.3 2253.6 2265.0 2280.2 2286.3 2301.5 2239.8 2245.0 2247.3 2263.5 2265.7 2190.0 2201.8 2208.4 2213.6 2222.4 8572.2 8655.0 8659.0 8746.4 8865.8 5020.4 5186.7 5187.9 5201.9 5230.7 3216.8 3368.8 3437.4 3450.6 3453.1 1173.5 1217.3 1219.7 1220.4 2119.5 11723.1 12116.6 12119.6 12124.9 12159.4 4393.5 4448.1 4465.3 4585.4 4736.1 9583.0 9618.8 9671.1 9679.4 9693.8 5020.1 5021.2 5022.8 5025.0 5026.5 4181.7 4301.2 4615.6 4686.1 4718.2 3597.6 3635.6 3651.0 3663.7 3702.0 1118.8 1128.6 1135.4 1135.7 1139.6 776.1 860.0 898.8 943.5 953.7 5808.0 5840.6 5869.4 5963.4 6075.8 916.6 921.0 944.5 945.7 998.5 3946.8 4039.2 4040.9 4067.9 4138.9 10387.6 10697.6 10713.5 10715.0 10729.5 10618.7 10647.2 10648.8 10678.8 10708.6 8081.6 8180.8 8208.0 8208.0 8222.1 5676.9 5737.9 5784.9 5889.1 5984.1 10021.9 10099.8 10106.2 10146.9 10200.3 9081.2 9363.3 9393.3 9533.4 9545.4 6870.6 7112.5 7592.1 7640.0 7870.3 8252.0 8642.6 8645.1 8648.4 8648.9 7324.7 7449.9 7504.5 7606.4 7672.1 7252.5 7300.4 7450.7 7534.0 7656.8 6934.9 6935.0 6937.3 6949.8 6950.1 4829.9 4897.4 4915.9 4932.5 4971.4 5042.9 5096.2 5141.8 5273.2 5306.8 02:55:17 INFO - PROCESS | 14814 | 02:55:17 INFO - PROCESS | 14814 | [#4] prototype.html Cycles:180 Average:4562.47 Median:5242.91 stddev:1333.45 (25.4%) stddev-sans-first:1298.92 02:55:17 INFO - PROCESS | 14814 | Values: 336.4 342.6 347.4 348.9 349.2 5242.5 5254.7 5264.7 5284.4 5325.4 5195.0 5212.8 5230.7 5234.8 5238.8 3828.9 3917.8 3963.7 4011.7 4058.0 4065.8 4071.6 4102.8 4113.3 4121.6 3989.3 4018.0 4029.0 4037.7 4042.2 3797.9 3832.9 3966.9 4000.4 4052.9 3589.6 3592.3 3592.6 3603.4 3623.1 5023.7 5024.8 5029.5 5034.4 5069.1 4570.3 4618.8 4658.5 4676.5 4716.2 5363.9 5383.0 5386.4 5389.7 5416.6 4015.5 4025.2 4030.0 4039.9 4050.6 5482.7 5525.6 5559.2 5587.8 5664.1 4089.4 4093.8 4094.7 4098.3 4114.2 4086.7 4138.3 4156.2 4160.1 4168.9 4364.7 4560.9 4638.5 4646.4 4651.6 5399.2 5407.8 5418.8 5419.5 5446.9 1387.6 1398.3 1403.5 1408.9 1414.4 848.9 908.9 914.4 920.5 934.9 5003.7 5067.0 5068.3 5122.2 5143.7 5415.5 5419.2 5427.3 5532.9 5574.4 4995.5 5136.8 5150.0 5180.3 5243.3 2853.0 2926.8 2928.5 2941.1 2975.2 5711.3 5716.3 5765.7 5768.7 5784.8 5507.2 5597.9 5603.0 5624.8 5711.9 5647.9 5661.5 5676.2 5705.5 5706.9 5375.0 5494.9 5536.5 5548.7 5598.4 5426.2 5458.3 5465.4 5468.2 5473.3 5685.5 5706.3 5709.4 5724.5 5748.9 3687.6 3710.5 3739.0 3749.8 3886.8 5517.8 5534.4 5540.8 5551.3 5554.5 5422.8 5442.5 5451.9 5517.5 5528.4 5287.5 5351.5 5418.0 5484.5 5502.5 5315.5 5317.9 5330.2 5344.5 5344.9 5192.9 5373.4 5374.4 5436.9 5457.2 5359.4 5367.5 5385.8 5388.1 5393.4 02:55:17 INFO - PROCESS | 14814 | 02:55:17 INFO - PROCESS | 14814 | [#5] yui.html Cycles:180 Average:19864.73 Median:27036.48 stddev:27137.13 (100.4%) stddev-sans-first:27175.26 02:55:17 INFO - PROCESS | 14814 | Values: 741.2 750.5 774.0 783.1 829.2 13447.7 13908.0 13915.5 13922.1 13928.5 13776.2 13799.5 13812.6 13828.3 13871.7 657.1 774.2 799.8 801.7 802.4 676.5 779.3 795.5 805.0 807.5 841.4 843.5 844.0 845.8 846.0 670.5 820.3 827.4 839.7 840.6 501.2 586.4 600.2 602.7 606.0 13570.5 13696.9 13712.1 13740.7 13769.7 12538.4 12715.3 13999.8 14277.9 14322.5 13217.9 13374.5 13513.4 13577.5 13592.3 3871.6 3925.4 4421.8 4491.4 4565.7 65406.7 75577.6 76023.0 76087.6 76203.0 11245.7 11455.7 11486.5 11500.8 11548.8 22472.7 22558.7 22798.4 22878.7 22887.5 8598.7 8604.4 8629.6 8709.1 8995.6 4846.7 4927.5 4947.6 4977.5 5113.6 3630.7 3667.9 3694.8 3715.9 3730.0 671.1 674.3 681.8 688.3 689.3 709.2 714.1 715.1 718.6 737.6 9685.0 9925.6 10282.8 10318.2 10381.2 741.6 753.2 763.6 784.2 787.6 4439.6 4878.7 4948.1 4979.3 4993.3 75034.6 91153.5 92382.0 94422.0 108686.5 88735.6 90682.0 91450.0 92265.5 93100.0 80643.6 80721.0 84042.6 84676.0 85404.1 9860.5 10252.3 10447.5 10538.8 10577.9 49194.3 49771.5 49862.3 50463.5 50732.2 67825.7 74599.6 74968.0 75541.6 76865.6 13157.9 13191.4 13359.7 13403.3 13508.7 13548.9 14046.9 14457.3 14624.5 15650.9 14101.6 14101.8 14285.9 14916.9 15313.2 13292.7 13855.8 14100.9 14893.5 15260.6 13925.3 14062.9 14069.8 14195.6 14447.3 11297.2 11470.0 11558.4 11688.4 12208.3 11846.4 11990.2 11997.8 12182.1 12359.1 02:55:17 INFO - PROCESS | 14814 | -------- Summary: end -------- 02:55:17 INFO - PROCESS | 14814 | 02:55:18 INFO - TEST-INFO | 14814: exit 0 02:55:18 INFO - TEST-OK | dromaeo_css | took 1116811ms 02:55:18 INFO - TEST-START | kraken 02:55:18 INFO - operating with platform_type : linux_ 02:55:18 INFO - Initialising browser for kraken test... 02:55:18 INFO - TEST-INFO | started process 15122 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc34k4o/profile http://localhost:57069/getInfo.html) 02:55:22 INFO - PROCESS | 15122 | __metrics Screen width/height:1600/1200 02:55:22 INFO - PROCESS | 15122 | colorDepth:24 02:55:22 INFO - PROCESS | 15122 | Browser inner width/height: 1024/697 02:55:22 INFO - PROCESS | 15122 | __metrics 02:55:22 INFO - PROCESS | 15122 | 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" 02:55:22 INFO - PROCESS | 15122 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:55:22 INFO - PROCESS | 15122 | console.error: PushService: 02:55:22 INFO - PROCESS | 15122 | stateChangeProcessEnqueue: Error transitioning state 02:55:22 INFO - PROCESS | 15122 | UnknownError 02:55:23 INFO - TEST-INFO | 15122: exit 0 02:55:23 INFO - Browser initialized. 02:55:23 INFO - Running cycle 1/1 for kraken test... 02:55:23 INFO - TEST-INFO | started process 15208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc34k4o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:55:35 INFO - PROCESS | 15208 | RSS: Main: 172584960 02:55:35 INFO - PROCESS | 15208 | 02:55:38 INFO - PROCESS | 15208 | Cycle 1(1): loaded http://localhost:57069/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57069/tests/kraken/driver.html?testName=audio-beat-detection) 02:55:39 INFO - PROCESS | 15208 | RSS: Main: 240726016 02:55:39 INFO - PROCESS | 15208 | 02:55:41 INFO - PROCESS | 15208 | Cycle 1(1): loaded http://localhost:57069/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57069/tests/kraken/driver.html?testName=audio-dft) 02:55:42 INFO - PROCESS | 15208 | RSS: Main: 216637440 02:55:42 INFO - PROCESS | 15208 | 02:55:45 INFO - PROCESS | 15208 | Cycle 1(1): loaded http://localhost:57069/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57069/tests/kraken/driver.html?testName=audio-fft) 02:55:46 INFO - PROCESS | 15208 | RSS: Main: 298004480 02:55:46 INFO - PROCESS | 15208 | 02:55:48 INFO - PROCESS | 15208 | Cycle 1(1): loaded http://localhost:57069/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57069/tests/kraken/driver.html?testName=audio-oscillator) 02:55:48 INFO - PROCESS | 15208 | RSS: Main: 206925824 02:55:48 INFO - PROCESS | 15208 | 02:55:50 INFO - PROCESS | 15208 | Cycle 1(1): loaded http://localhost:57069/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57069/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:55:51 INFO - PROCESS | 15208 | RSS: Main: 212209664 02:55:51 INFO - PROCESS | 15208 | 02:55:54 INFO - PROCESS | 15208 | Cycle 1(1): loaded http://localhost:57069/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57069/tests/kraken/driver.html?testName=imaging-darkroom) 02:55:55 INFO - PROCESS | 15208 | RSS: Main: 248475648 02:55:55 INFO - PROCESS | 15208 | 02:55:58 INFO - PROCESS | 15208 | Cycle 1(1): loaded http://localhost:57069/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57069/tests/kraken/driver.html?testName=imaging-desaturate) 02:55:59 INFO - PROCESS | 15208 | RSS: Main: 247472128 02:55:59 INFO - PROCESS | 15208 | 02:56:01 INFO - PROCESS | 15208 | Cycle 1(1): loaded http://localhost:57069/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57069/tests/kraken/driver.html?testName=json-parse-financial) 02:56:02 INFO - PROCESS | 15208 | RSS: Main: 248205312 02:56:02 INFO - PROCESS | 15208 | 02:56:04 INFO - PROCESS | 15208 | Cycle 1(1): loaded http://localhost:57069/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57069/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:56:04 INFO - PROCESS | 15208 | RSS: Main: 209604608 02:56:04 INFO - PROCESS | 15208 | 02:56:06 INFO - PROCESS | 15208 | Cycle 1(1): loaded http://localhost:57069/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57069/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:56:07 INFO - PROCESS | 15208 | RSS: Main: 217001984 02:56:07 INFO - PROCESS | 15208 | 02:56:09 INFO - PROCESS | 15208 | Cycle 1(1): loaded http://localhost:57069/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57069/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:56:09 INFO - PROCESS | 15208 | RSS: Main: 226910208 02:56:09 INFO - PROCESS | 15208 | 02:56:12 INFO - PROCESS | 15208 | Cycle 1(1): loaded http://localhost:57069/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57069/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:56:13 INFO - PROCESS | 15208 | RSS: Main: 235773952 02:56:13 INFO - PROCESS | 15208 | 02:56:15 INFO - PROCESS | 15208 | Cycle 1(1): loaded http://localhost:57069/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57069/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:56:16 INFO - PROCESS | 15208 | RSS: Main: 231849984 02:56:16 INFO - PROCESS | 15208 | 02:56:18 INFO - PROCESS | 15208 | Cycle 1(1): loaded http://localhost:57069/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57069/tests/kraken/driver.html?testName=ai-astar) 02:56:18 INFO - PROCESS | 15208 | RSS: Main: 283537408 02:56:18 INFO - PROCESS | 15208 | 02:56:18 INFO - PROCESS | 15208 | __start_tp_report 02:56:18 INFO - PROCESS | 15208 | _x_x_mozilla_page_load 02:56:18 INFO - PROCESS | 15208 | _x_x_mozilla_page_load_details 02:56:18 INFO - PROCESS | 15208 | |i|pagename|runs| 02:56:18 INFO - PROCESS | 15208 | |0;ai-astar;107;111;111;112;111;110;111;112;110;112 02:56:18 INFO - PROCESS | 15208 | |1;audio-beat-detection;157;125;120;178;128;122;121;124;153;122 02:56:18 INFO - PROCESS | 15208 | |2;audio-dft;161;162;161;160;160;163;162;161;163;161 02:56:18 INFO - PROCESS | 15208 | |3;audio-fft;75;77;77;107;76;77;75;75;107;75 02:56:18 INFO - PROCESS | 15208 | |4;audio-oscillator;82;83;114;82;81;83;111;82;82;111 02:56:18 INFO - PROCESS | 15208 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;117;117 02:56:18 INFO - PROCESS | 15208 | |6;imaging-darkroom;146;146;146;145;145;146;146;145;146;145 02:56:18 INFO - PROCESS | 15208 | |7;imaging-desaturate;95;95;95;95;95;94;94;95;95;94 02:56:18 INFO - PROCESS | 15208 | |8;json-parse-financial;50;50;51;52;53;53;58;53;52;52 02:56:18 INFO - PROCESS | 15208 | |9;json-stringify-tinderbox;61;61;61;61;63;62;61;61;63;66 02:56:18 INFO - PROCESS | 15208 | |10;stanford-crypto-aes;80;79;80;80;79;80;79;85;79;79 02:56:18 INFO - PROCESS | 15208 | |11;stanford-crypto-ccm;130;139;130;136;137;127;129;127;176;130 02:56:18 INFO - PROCESS | 15208 | |12;stanford-crypto-pbkdf2;164;165;166;163;167;169;165;169;164;166 02:56:18 INFO - PROCESS | 15208 | |13;stanford-crypto-sha256-iterative;66;70;66;66;66;66;67;66;66;64 02:56:18 INFO - PROCESS | 15208 | __end_tp_report 02:56:18 INFO - PROCESS | 15208 | __start_cc_report 02:56:18 INFO - PROCESS | 15208 | _x_x_mozilla_cycle_collect,1698 02:56:18 INFO - PROCESS | 15208 | __end_cc_report 02:56:18 INFO - PROCESS | 15208 | __startTimestamp1476352578447__endTimestamp 02:56:18 INFO - PROCESS | 15208 | 02:56:18 INFO - PROCESS | 15208 | ------- Summary: start ------- 02:56:18 INFO - PROCESS | 15208 | Number of tests: 14 02:56:18 INFO - PROCESS | 15208 | 02:56:18 INFO - PROCESS | 15208 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.49 (1.3%) stddev-sans-first:0.78 02:56:18 INFO - PROCESS | 15208 | Values: 107.0 111.0 111.0 112.0 111.0 110.0 111.0 112.0 110.0 112.0 02:56:18 INFO - PROCESS | 15208 | 02:56:18 INFO - PROCESS | 15208 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:126.50 stddev:20.24 (16.0%) stddev-sans-first:19.84 02:56:18 INFO - PROCESS | 15208 | Values: 157.0 125.0 120.0 178.0 128.0 122.0 121.0 124.0 153.0 122.0 02:56:18 INFO - PROCESS | 15208 | 02:56:18 INFO - PROCESS | 15208 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 02:56:18 INFO - PROCESS | 15208 | Values: 161.0 162.0 161.0 160.0 160.0 163.0 162.0 161.0 163.0 161.0 02:56:18 INFO - PROCESS | 15208 | 02:56:18 INFO - PROCESS | 15208 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.50 stddev:13.15 (17.4%) stddev-sans-first:13.70 02:56:18 INFO - PROCESS | 15208 | Values: 75.0 77.0 77.0 107.0 76.0 77.0 75.0 75.0 107.0 75.0 02:56:18 INFO - PROCESS | 15208 | 02:56:18 INFO - PROCESS | 15208 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:82.00 stddev:14.46 (17.6%) stddev-sans-first:14.95 02:56:18 INFO - PROCESS | 15208 | Values: 82.0 83.0 114.0 82.0 81.0 83.0 111.0 82.0 82.0 111.0 02:56:18 INFO - PROCESS | 15208 | 02:56:18 INFO - PROCESS | 15208 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:56:18 INFO - PROCESS | 15208 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 02:56:18 INFO - PROCESS | 15208 | 02:56:18 INFO - PROCESS | 15208 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:56:18 INFO - PROCESS | 15208 | Values: 146.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 145.0 02:56:18 INFO - PROCESS | 15208 | 02:56:18 INFO - PROCESS | 15208 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:56:18 INFO - PROCESS | 15208 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 94.0 02:56:18 INFO - PROCESS | 15208 | 02:56:18 INFO - PROCESS | 15208 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.50 stddev:2.27 (4.3%) stddev-sans-first:2.24 02:56:18 INFO - PROCESS | 15208 | Values: 50.0 50.0 51.0 52.0 53.0 53.0 58.0 53.0 52.0 52.0 02:56:18 INFO - PROCESS | 15208 | 02:56:18 INFO - PROCESS | 15208 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:61.50 stddev:1.63 (2.7%) stddev-sans-first:1.69 02:56:18 INFO - PROCESS | 15208 | Values: 61.0 61.0 61.0 61.0 63.0 62.0 61.0 61.0 63.0 66.0 02:56:18 INFO - PROCESS | 15208 | 02:56:18 INFO - PROCESS | 15208 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.00 stddev:1.83 (2.3%) stddev-sans-first:1.94 02:56:18 INFO - PROCESS | 15208 | Values: 80.0 79.0 80.0 80.0 79.0 80.0 79.0 85.0 79.0 79.0 02:56:18 INFO - PROCESS | 15208 | 02:56:18 INFO - PROCESS | 15208 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:133.00 stddev:14.64 (11.0%) stddev-sans-first:15.36 02:56:18 INFO - PROCESS | 15208 | Values: 130.0 139.0 130.0 136.0 137.0 127.0 129.0 127.0 176.0 130.0 02:56:18 INFO - PROCESS | 15208 | 02:56:18 INFO - PROCESS | 15208 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:166.00 stddev:2.04 (1.2%) stddev-sans-first:2.06 02:56:18 INFO - PROCESS | 15208 | Values: 164.0 165.0 166.0 163.0 167.0 169.0 165.0 169.0 164.0 166.0 02:56:18 INFO - PROCESS | 15208 | 02:56:18 INFO - PROCESS | 15208 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:1.49 (2.3%) stddev-sans-first:1.58 02:56:18 INFO - PROCESS | 15208 | Values: 66.0 70.0 66.0 66.0 66.0 66.0 67.0 66.0 66.0 64.0 02:56:18 INFO - PROCESS | 15208 | -------- Summary: end -------- 02:56:18 INFO - PROCESS | 15208 | 02:56:19 INFO - TEST-INFO | 15208: exit 0 02:56:19 INFO - TEST-OK | kraken | took 61479ms 02:56:19 INFO - SUITE-END | took 1178s 02:56:20 INFO - Completed test suite (00:19:38) 02:56:20 INFO - javascript benchmark 02:56:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3010.6236720409947, 3028.061300996691, 3032.848357582121, 3072.1551573317347, 3087.907362779116, 5053.039922414748, 5126.897462050757, 5137.332146820912, 5206.167013277876, 5254.316938797951, 5138.511841375063, 5214.322138122048, 5320.494553017457, 5329.0, 5340.519353258206, 4584.862454126382, 4589.196890544158, 4643.466001409831, 4668.323093151491, 4671.135839869618, 4190.643795277405, 4727.5272472752795, 4786.2581299898575, 4798.688085274446, 4848.733319667417, 4678.836240731558, 4691.179043667345, 4723.858284251478, 4733.431988161408, 4771.284307353907, 4588.082383523275, 4627.768611569408, 4630.3748993886065, 4673.953260467386, 4712.787924543404, 4668.509806470306, 4671.5795578397765, 4683.648726345537, 4733.171694953369, 4741.217699079648, 5220.686758794484, 5238.659487133325, 5243.973780131075, 5244.265802787613, 5280.973595132038, 5353.491418315254, 5415.675059496442, 5491.258680078178, 5623.634463759842, 5628.296462942132, 5525.143602741541, 5595.692236926968, 5612.775488980476, 5622.1004639257935, 5684.34630017545, 5240.633155679104, 5240.9213861792105, 5245.947540524546, 5250.7637156328055, 5251.973740131351, 5573.191887176336, 5628.324601047901, 5703.600747947687, 5703.62926409782, 5766.135079738073, 5281.524662780368, 5305.522502974751, 5382.273393091961, 5383.569314454834, 5438.809641662523, 5349.81275655358, 5359.954808812322, 5393.649412788156, 5443.401225865152, 5447.618666693294, 5366.148480615043, 5422.349318081855, 5423.891522169534, 5431.293931788842, 5485.862853428696, 5302.549283310885, 5352.705601191972, 5422.5119739223655, 5532.944670553324, 5537.529310008614, 4309.504406993173, 4333.501647310537, 4336.0, 4336.046069864625, 4388.978055109704, 3853.7109716771356, 3867.5939026402384, 3882.1265215326325, 3903.1998440319667, 3908.0, 5065.214891691794, 5117.283580298761, 5183.559397451183, 5249.186376111708, 5251.579873610102, 5623.268975033219, 5628.577856660685, 5629.24005259293, 5633.352164501053, 5646.774129034792, 5248.895022099613, 5255.3168088148295, 5257.553107985864, 5259.894802103937, 5323.520883120537, 4751.596114330251, 4760.285957106462, 4791.736454494967, 4834.371531700926, 4844.2007068833955, 5668.376478587352, 5751.683657398883, 5754.9424505754405, 5809.88380232393, 5815.273090863727, 5537.141743029837, 5544.3346798384455, 5557.277553917965, 5558.72206389687, 5568.49883510486, 5660.405657406078, 5700.458456446631, 5731.627444216113, 5731.7420716067045, 5748.252727145445, 5513.696746678971, 5530.364008139116, 5536.501714845684, 5538.0, 5538.086215774352, 5594.300712410949, 5600.943990560042, 5607.747651355618, 5608.074667679787, 5616.045272303636, 5472.50747432733, 5480.451954804487, 5481.643693159932, 5492.47821456961, 5493.09363954943, 5444.156155795699, 5475.206095116107, 5487.862803429946, 5514.255575497256, 5523.337199536081, 5360.812371566976, 5378.435264297349, 5380.757865895966, 5381.48875856793, 5387.164989426645, 5368.677879327252, 5390.757415916215, 5465.262189604353, 5466.098093814476, 5479.0, 5331.093714068696, 5334.279872217201, 5334.973325133349, 5336.0, 5342.679439233503], "value": 5117.252345659504, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.7164289498145, 583.2068386993687, 598.2671227746009, 599.7541008186645, 604.5224272824472, 42476.36285455717, 44024.559754402486, 44447.77776111123, 48205.7589712051, 48225.517744822544, 45867.77066114665, 46254.0, 46393.76803115988, 46409.7679511602, 46431.76784116075, 7938.24586664266, 8866.335024873128, 9003.0, 9011.459312441242, 9023.503707296097, 8035.598220089001, 8332.70835520757, 8344.08215096339, 10473.947630261877, 10744.247902646817, 10900.836487452694, 11041.061509771678, 11041.779164416746, 11048.226624136314, 11054.447277636125, 10801.135909127252, 10869.293495922779, 10883.67348979532, 10885.183611229111, 10887.673369798918, 10560.155187585051, 10589.258751887372, 10596.099331556827, 10660.307080039851, 10668.039876411083, 42097.57902420967, 42415.1516969662, 42498.36252456216, 42655.786721066506, 42767.144657106684, 3499.475078738184, 3671.3575124353133, 4040.636342729139, 4079.9796001019804, 4115.938260926088, 32038.83980580082, 32250.51624225615, 32428.675713243036, 33163.0, 33221.33557328864, 4308.332208507655, 4329.177456283296, 4345.109252603241, 4444.844430444951, 4593.5406459354135, 324694.0, 324704.0, 329836.0, 330902.9999999976, 331014.0, 34590.0, 59413.405865941655, 60003.499912502535, 60082.39917600768, 60096.699516502136, 37967.24065518729, 38020.429693554615, 38135.0, 38181.23637527234, 38184.0, 14362.569122926328, 14439.278036098152, 14444.061136026125, 14470.638234044232, 14485.92757036208, 11895.881041189477, 13388.263645499395, 13442.0, 13474.0, 13492.257925814174, 8007.359411247086, 8502.617382217815, 8658.350623703247, 8752.8687069694, 8878.511681857432, 3351.145457908218, 3355.6644335566248, 3386.5258863759095, 3406.863725450954, 3408.2161102945965, 1024.2318261304022, 1031.4120951057826, 1037.2376303416982, 1037.4138611684375, 1095.0691911874842, 31746.841265793522, 31926.0, 32051.0, 32690.836545817117, 32841.0, 1070.1438848920832, 1100.389283947417, 1114.8606424196976, 1135.0238794636605, 1178.505027888289, 16170.514884553248, 16714.498565043068, 16799.91600041992, 16833.41083062087, 17097.658046839242, 494712.0, 496819.0, 498828.0, 499725.0, 502314.0, 56984.715076424356, 57246.713766431734, 57338.7133064332, 57412.13881791777, 57503.424965750644, 1169.2984209474419, 1221.7861874171983, 1290.8709129087017, 1295.799151131576, 1299.5581502289267, 29053.564196536645, 33047.390521896195, 33217.66782332242, 33351.0, 33521.0, 53602.19596705974, 55383.0, 55430.0, 61503.0, 61543.38456615376, 474429.0, 478758.0, 479015.0, 479318.0, 479455.0, 28134.43731125407, 28216.0, 28453.0, 30618.693813061585, 43381.40825355487, 46279.53720462752, 46611.300830488246, 46739.766301169635, 46936.7653161732, 47135.292970606155, 39411.60588394194, 40798.59201407948, 41051.58948410597, 41292.0, 42234.78882605567, 40420.79789601033, 40482.534857795, 41476.58523414727, 41589.58410415857, 41773.6009397883, 40421.797891010356, 40901.79549102354, 41371.1725765489, 43926.0, 44014.779926100164, 34359.0, 36864.81567592145, 37282.25435491329, 37340.813295933345, 37418.812905935294, 27652.861735691193, 28111.43777124405, 28315.292117697223, 28408.0, 28480.572791407732], "value": 19449.50773692168, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.6572419098621, 392.26058879013067, 403.7173978215248, 406.1329062451665, 419.9895002624934, 13711.314434278296, 15290.235488225586, 18722.812771872294, 19011.429657110308, 19399.515012124702, 18177.727334089966, 18219.36232231872, 18339.08304584772, 18675.719864202012, 18738.96935668538, 5285.312909321783, 5465.289512363387, 5702.800401985931, 5709.8572535686735, 5711.600187986843, 5335.226392173133, 5668.404817494165, 5689.345725241588, 5693.487586117249, 5694.174344720013, 5468.91796623051, 5660.9433905661035, 5662.5753068520025, 5666.716664166795, 5669.574781891354, 5721.199032135483, 5853.356130825606, 5897.675627840467, 5903.026000709878, 5907.586468947154, 5576.442355764431, 5712.771489140429, 5720.713964301768, 5740.110282906115, 5748.0, 13957.860421395757, 14187.219702916336, 14196.432142714279, 16310.592235194097, 21811.563768724696, 2119.724435823333, 2260.8417410781253, 2292.33522278539, 2305.5965206088867, 2509.6794795034643, 10105.242106842017, 10142.89857101427, 10337.37975721459, 10693.251472396858, 10728.409937453436, 1879.7274395212755, 1904.9047547622702, 1907.3419670213755, 1926.5761532462836, 1939.8739081959768, 84781.0, 86121.56939215264, 86586.0, 87002.0, 87515.0, 10750.463511291691, 11009.0, 11046.33721976684, 11065.0, 11149.331040137455, 15772.211389430482, 15824.129672868103, 15829.525114246591, 15846.920765396098, 15851.682966340608, 7562.2437756223935, 7815.218478152253, 7942.722004729807, 8040.195980401913, 8134.502164069507, 7453.515521491194, 7504.287092726182, 7657.57883316423, 7770.0675918888965, 7799.454038217384, 4592.563706447882, 4711.884901422036, 4716.528347165256, 4750.596199323028, 4854.854354369375, 1951.7462729845313, 1967.1672791180654, 1973.575681228514, 1986.3742920979846, 2014.5769388428594, 820.2986446588201, 902.354816306331, 926.5321012888448, 948.7580666930027, 997.8004399120205, 16749.91625041867, 16990.150492475328, 17460.738088928676, 17870.91064544669, 18313.7252941206, 869.1786261982493, 907.1065000974036, 914.2685851318919, 936.7564433247269, 964.5370222293338, 10043.296969212231, 10071.59713611462, 10099.394036357842, 10181.796364072678, 10194.898051019394, 328356.0, 332877.0, 332964.0, 451124.0, 451206.0, 56819.715901420226, 59665.40334596685, 70015.94976075363, 83896.73755461586, 99349.0, 991.6578780320777, 1012.6152062216311, 1040.5057597641212, 1043.0768769638773, 1048.9003544663244, 16753.74869376936, 16969.490915272563, 17729.290828367237, 17952.678998565072, 17986.910065450113, 41734.58265417307, 42191.789041055825, 42440.575594244896, 43821.561784381745, 44998.77500612607, 61153.38846611477, 61234.38765612287, 62357.0, 62776.68611656912, 63075.6846215766, 8534.487930724177, 8552.401331906707, 8710.564471776512, 8839.734807955772, 8910.55447227649, 12045.75908481843, 12419.875801241871, 13062.738745224851, 13079.280639564915, 13238.801417978546, 5889.087191485327, 8782.91217087821, 10626.256162068581, 10787.0, 11960.940195298968, 10737.785244294913, 10839.891601083888, 10992.17558683118, 11521.654350369503, 12028.338441385458, 11298.209125361145, 11504.597339093092, 11545.422728863356, 11555.191136620357, 11957.760844782882, 8574.52840093776, 8654.524001179996, 8675.089115642766, 8803.075677053817, 8916.592520019429, 10609.681709548726, 11018.559257629926, 11642.53429862796, 11707.531698731955, 12002.099842512021], "value": 8863.414053059796, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.3671256153323, 1442.632128807154, 1485.9851401485985, 1582.6122599963012, 1730.5846596816768, 7429.62851857407, 8207.794805129868, 8432.873506897393, 8461.619227134779, 8720.040795512488, 8598.44110132841, 8651.610677519511, 8673.349498787584, 8673.609687564074, 8675.26260267878, 2264.1735766445213, 2302.7466978632337, 2304.6427803690453, 2307.861528308307, 2310.9075636974585, 2226.3209721035078, 2259.3109101723967, 2316.8494047886834, 2321.802646775026, 2322.3381336319153, 2253.5943530164564, 2264.9660255096187, 2280.2019293247313, 2286.336962280945, 2301.5281867217263, 2239.8432109752325, 2245.0346351069034, 2247.2696373678536, 2263.5359751250953, 2265.728112626487, 2189.9890500547554, 2201.757806641268, 2208.3595757230382, 2213.5904857601395, 2222.4443889027743, 8572.185642364027, 8654.956725216396, 8659.0, 8746.431481953652, 8865.822683546294, 5020.397552293712, 5186.662866913639, 5187.922181167285, 5201.9479805201845, 5230.712310822903, 3216.8391580420885, 3368.8147151906637, 3437.3812713711523, 3450.6204317525053, 3453.1021934297264, 1173.5423184957874, 1217.31221859649, 1219.71336735867, 1220.4263995921901, 2119.4807272218404, 11723.120765942589, 12116.636500904988, 12119.575814846437, 12124.939375303155, 12159.392030398445, 4393.450818647669, 4448.110377924428, 4465.330200469891, 4585.358049873021, 4736.123817093849, 9583.041695830361, 9618.759531011781, 9671.081247281498, 9679.37084089546, 9693.806123877483, 5020.1214787412055, 5021.221710634857, 5022.799088036438, 5025.0, 5026.472220416877, 4181.707280490336, 4301.204277208726, 4615.630749540029, 4686.109639168615, 4718.245080787057, 3597.6222496638, 3635.563732352082, 3651.0, 3663.6519530644546, 3702.0, 1118.8364101334685, 1128.610629332879, 1135.392564977733, 1135.6990397544657, 1139.5783560082657, 776.0609662308669, 859.9914000860036, 898.8067565473324, 943.528235882059, 953.68051702679, 5807.970960145172, 5840.620359676607, 5869.413058694096, 5963.373845746221, 6075.787347442818, 916.5508900638639, 920.963161473547, 944.5182956691999, 945.716285114463, 998.5356809083811, 3946.8026598669953, 4039.1517781265675, 4040.8585699500964, 4067.8576249831112, 4138.91722165561, 10387.584496620202, 10697.625583104555, 10713.517891694892, 10715.0, 10729.517171727291, 10618.681439556825, 10647.201459890539, 10648.78702425947, 10678.786424271471, 10708.625198118028, 8081.555514446762, 8180.7954801130445, 8207.95896020516, 8208.0, 8222.054463736627, 5676.914846277392, 5737.885242295214, 5784.942150578609, 5889.087191485327, 5984.102384642339, 10021.899781002388, 10099.798004040025, 10106.242031847787, 10146.898531014594, 10200.285979981627, 9081.228095611683, 9363.29775266844, 9393.342466027585, 9533.427994320364, 9545.427274363283, 6870.553414028072, 7112.466565007541, 7592.126905405949, 7640.0, 7870.29167374939, 8252.0, 8642.567871606268, 8645.135486451305, 8648.43785153963, 8648.870266946127, 7324.743633972786, 7449.925500744923, 7504.512206706547, 7606.429517786299, 7672.117706463828, 7252.456065795192, 7300.415966722756, 7450.739224127129, 7534.0, 7656.846863062596, 6934.895976560457, 6934.965325173342, 6937.340952609494, 6949.791506254821, 6950.061741665013, 4829.903401932012, 4897.436794768647, 4915.901681966412, 4932.506749325183, 4971.37857767779, 5042.949570504248, 5096.210087436453, 5141.845744627667, 5273.2090186470805, 5306.761195746123], "value": 4534.486465466908, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.39113205098766, 342.60771416727846, 347.41807472483583, 348.92846966371894, 349.1550447916046, 5242.501962313579, 5254.737263136837, 5264.684118952866, 5284.4187139414635, 5325.387580428247, 5195.03891780021, 5212.76542555585, 5230.712310822903, 5234.816781412651, 5238.7642556084975, 3828.942565861514, 3917.7649341039487, 3963.6829053675638, 4011.699122565805, 4058.0, 4065.837366505351, 4071.5928407159195, 4102.753834769924, 4113.25961326961, 4121.629053385194, 3989.321815291393, 4017.9799101004455, 4028.96537248689, 4037.7173597848164, 4042.2117687051036, 3797.8670746524017, 3832.923341533168, 3966.86115985942, 4000.3599424092295, 4052.9189416211807, 3589.569251689788, 3592.281543691246, 3592.6227746086547, 3603.40543810271, 3623.0942264433893, 5023.6985780853265, 5024.773885175176, 5029.497050294978, 5034.421041580228, 5069.1129052416045, 4570.337301091323, 4618.838340658061, 4658.510856360067, 4676.485586585472, 4716.198246298138, 5363.946360536423, 5382.973085134549, 5386.380566234894, 5389.703566303851, 5416.566674666017, 4015.4779878615886, 4025.1547175092974, 4029.959700403017, 4039.8586049488126, 4050.5949405059555, 5482.725863706799, 5525.64083334586, 5559.249501317311, 5587.776488940438, 5664.122061080539, 4089.44792453021, 4093.7953102344763, 4094.6519545838937, 4098.344264917599, 4114.218298523331, 4086.693497987663, 4138.337865941435, 4156.210320039183, 4160.1471698301775, 4168.937465938014, 4364.650827933758, 4560.931586026212, 4638.489766125724, 4646.372739680168, 4651.5813576778255, 5399.163129714901, 5407.810726624549, 5418.83743487696, 5419.458054194628, 5446.945530544644, 1387.555982085723, 1398.321813920248, 1403.5122769863772, 1408.9225092620004, 1414.4342263094638, 848.9320854331638, 908.8682141089505, 914.3964983111115, 920.5397301349325, 934.8550974598948, 5003.749812509433, 5066.98514383941, 5068.315777370081, 5122.231665250242, 5143.71709555978, 5415.48552887475, 5419.214213938957, 5427.255193916264, 5532.944670553324, 5574.442555744393, 4995.500449955048, 5136.794528218904, 5149.9742501287255, 5180.274761533388, 5243.318368612056, 2852.971470285312, 2926.809757365764, 2928.546075358323, 2941.0882926098207, 2975.1851370663876, 5711.257536520226, 5716.256886604715, 5765.654060756284, 5768.740406681625, 5784.768609255582, 5507.237683941181, 5597.944020559824, 5602.971985140048, 5624.775008999676, 5711.914321285184, 5647.858803529944, 5661.518770904519, 5676.205331253628, 5705.5150312223095, 5706.9429305707245, 5375.0, 5494.890102197854, 5536.501714845684, 5548.667079975215, 5598.440155984532, 5426.158945363475, 5458.344998600193, 5465.426130256425, 5468.179773034077, 5473.31583552056, 5685.545156387562, 5706.343770466449, 5709.371969083314, 5724.542036637143, 5748.885022299447, 3687.6128006558924, 3710.4990826238113, 3738.9904725724446, 3749.831257593469, 3886.825092870771, 5517.806876759294, 5534.391216966211, 5540.7783688652, 5551.278333816578, 5554.472325129106, 5422.810201642924, 5442.510174084351, 5451.918221226605, 5517.531009864046, 5528.391876893619, 5287.471252874681, 5351.491608297206, 5418.024755543882, 5484.451554844483, 5502.504774570148, 5315.521603055744, 5317.920231196458, 5330.173823057432, 5344.4922732340365, 5344.866378340417, 5192.896142077062, 5373.35519737634, 5374.441411990479, 5436.939796739598, 5457.181422786455, 5359.437259087739, 5367.5169234769055, 5385.8114965976, 5388.137897936312, 5393.352797664305], "value": 4141.925006210261, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.2032065529556, 750.523417629805, 773.9806504837378, 783.1346362269692, 829.1873963515758, 13447.731045379087, 13908.026438149322, 13915.512957046505, 13922.095063820845, 13928.51250206243, 13776.24230667313, 13799.517016904385, 13812.585622431317, 13828.308584570756, 13871.653208669763, 657.1227411405755, 774.2025713515088, 799.8240387114826, 801.7033697531922, 802.4262652203673, 676.5399528320739, 779.3375630713876, 795.4908858330673, 804.9678012879477, 807.5235610989515, 841.364769598952, 843.4517563583659, 844.012505368717, 845.7800971747359, 846.0143932318872, 670.4502308107354, 820.327331588098, 827.3670641958906, 839.7019058234331, 840.6175190288435, 501.21809976436873, 586.3755100817616, 600.2376981233853, 602.6655206360468, 606.0152252589542, 13570.525031623845, 13696.863031369758, 13712.108712933627, 13740.725185496234, 13769.655758606015, 12538.373081345897, 12715.300658463873, 13999.790003149961, 14277.857221427757, 14322.483270112178, 13217.933910330483, 13374.531891383755, 13513.418943979854, 13577.52478663242, 13592.25242611656, 3871.593482684306, 3925.3523168677134, 4421.801018954123, 4491.438570178728, 4565.680402371835, 65406.67296663486, 75577.62211188964, 76023.0, 76087.6195619024, 76202.99999999945, 11245.718857028476, 11455.656330310105, 11486.540538378538, 11500.827487587692, 11548.826767598493, 22472.662910056362, 22558.661620075713, 22798.430039249153, 22878.65682014771, 22887.542249154925, 8598.699045533376, 8604.35467339952, 8629.61166747498, 8709.129087091367, 8995.595198216097, 4846.660733748604, 4927.531884470969, 4947.5794557462295, 4977.502249774993, 5113.565346945551, 3630.673239408466, 3667.94498082529, 3694.7783133011567, 3715.888523344304, 3729.9813500932323, 671.0739179931663, 674.2919934069208, 681.8397676546008, 688.3357559954668, 689.2934741889603, 709.1879797631683, 714.1073657927591, 715.1418298042266, 718.558086776639, 737.5943231222806, 9684.95157524208, 9925.553350099262, 10282.845757313646, 10318.226133040052, 10381.169506439466, 741.5847125609675, 753.179034852014, 763.6029264782283, 784.1648644193915, 787.6219414680985, 4439.600435960779, 4878.707277563287, 4948.059868625021, 4979.253112033151, 4993.300937868701, 75034.6248268766, 91153.54423227841, 92382.0, 94422.0, 108686.45656771665, 88735.55632221927, 90682.0, 91450.0, 92265.53867230755, 93100.0, 80643.59678201571, 80721.0, 84042.57978710068, 84676.0, 85404.14595854086, 9860.506974651094, 10252.333598316383, 10447.477626118512, 10538.841917371092, 10577.894221057692, 49194.26208606945, 49771.50228497814, 49862.252066219764, 50463.49536504588, 50732.239016414045, 67825.66087169532, 74599.62700186681, 74968.0, 75541.62229188818, 76865.61567192129, 13157.934210328887, 13191.406386712813, 13359.666008349868, 13403.25757651499, 13508.729825403241, 13548.86451135476, 14046.929765351108, 14457.27713614294, 14624.488142914946, 15650.921745391655, 14101.647458813612, 14101.788473172706, 14285.857141428869, 14916.85083149198, 15313.157776322409, 13292.667683307995, 13855.792163117763, 14100.929495352868, 14893.478728244892, 15260.618484537976, 13925.303734813422, 14062.859371406565, 14069.788953165506, 14195.574132776033, 14447.277636117942, 11297.209195356247, 11470.0, 11558.42207889619, 11688.415579220835, 12208.328541929925, 11846.407679616157, 11990.220635658654, 11997.76004479923, 12182.14724969279, 12359.134860559674], "value": 7569.359217785361, "unit": "score"}], "name": "dromaeo_css", "value": 7075.062890661201, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 111.0, 112.0, 111.0, 110.0, 111.0, 112.0, 110.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 120.0, 178.0, 128.0, 122.0, 121.0, 124.0, 153.0, 122.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 160.0, 160.0, 163.0, 162.0, 161.0, 163.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 107.0, 76.0, 77.0, 75.0, 75.0, 107.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 114.0, 82.0, 81.0, 83.0, 111.0, 82.0, 82.0, 111.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 51.0, 52.0, 53.0, 53.0, 58.0, 53.0, 52.0, 52.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 63.0, 62.0, 61.0, 61.0, 63.0, 66.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 80.0, 80.0, 79.0, 80.0, 79.0, 85.0, 79.0, 79.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 139.0, 130.0, 136.0, 137.0, 127.0, 129.0, 127.0, 176.0, 130.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 166.0, 163.0, 167.0, 169.0, 165.0, 169.0, 164.0, 166.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 64.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1500.0, "alertThreshold": 2.0}]} 02:56:20 INFO - Return code: 0 02:56:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:56:20 INFO - # TBPL SUCCESS # 02:56:20 INFO - Running post-action listener: _resource_record_post_action 02:56:20 INFO - [mozharness: 2016-10-13 09:56:20.260066Z] Finished run-tests step (success) 02:56:20 INFO - Running post-run listener: _resource_record_post_run 02:56:20 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 407048192; Read time: 244; Write time: 266992 02:56:20 INFO - TinderboxPrint: CPU usage
13.1% 02:56:20 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 244 02:56:20 INFO - TinderboxPrint: I/O write bytes / time
407,048,192 / 266,992 02:56:20 INFO - TinderboxPrint: CPU idle
8,296.2 (86.9%) 02:56:20 INFO - TinderboxPrint: CPU user
1,199.8 (12.6%) 02:56:20 INFO - TinderboxPrint: Swap in / out
0 / 0 02:56:20 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 103985152; Read time: 172; Write time: 72256 02:56:20 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291651584; Read time: 72; Write time: 192096 02:56:20 INFO - Running post-run listener: _upload_blobber_files 02:56:20 INFO - Blob upload gear active. 02:56:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:56:20 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 02:56:20 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:56:20 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:56:21 INFO - (blobuploader) - INFO - Open directory for files ... 02:56:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:56:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:56:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:21 INFO - (blobuploader) - INFO - Done attempting. 02:56:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:56:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:56:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:22 INFO - (blobuploader) - INFO - Done attempting. 02:56:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:56:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:56:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:27 INFO - (blobuploader) - INFO - Done attempting. 02:56:27 INFO - (blobuploader) - INFO - Iteration through files over. 02:56:27 INFO - Return code: 0 02:56:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:56:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:56:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9bdc48487284c4fbedc43c667b5a6110924aad661cdf7e206ed7491fad9106637c954839e8321b8870ecdc321e14641d84c3548284cf55bc5310f7c6eb514a44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/96f1a399218f46c19371e2d5970c8f5a33362062165fac49321e7682044448197659d63bbe85ae08687f8a7f8cfd7a7af50b6d0630c2ad41c8fefb17c71dffa0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c011f858f99dbb5a30f512e405703229e62ab226748cd6e6a200ade44946a4666f920477d45167a72898abb395ee66686502d9075b9c47e99cbcb2d985722a8f"} 02:56:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:56:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:56:27 INFO - Contents: 02:56:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9bdc48487284c4fbedc43c667b5a6110924aad661cdf7e206ed7491fad9106637c954839e8321b8870ecdc321e14641d84c3548284cf55bc5310f7c6eb514a44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/96f1a399218f46c19371e2d5970c8f5a33362062165fac49321e7682044448197659d63bbe85ae08687f8a7f8cfd7a7af50b6d0630c2ad41c8fefb17c71dffa0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c011f858f99dbb5a30f512e405703229e62ab226748cd6e6a200ade44946a4666f920477d45167a72898abb395ee66686502d9075b9c47e99cbcb2d985722a8f"} 02:56:27 INFO - Running post-run listener: copy_logs_to_upload_dir 02:56:27 INFO - Copying logs to upload dir... 02:56:27 INFO - mkdir: /builds/slave/test/build/upload/logs 02:56:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.703646 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-13 02:56:26.888088) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 02:56:26.892145) ========= 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=0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9bdc48487284c4fbedc43c667b5a6110924aad661cdf7e206ed7491fad9106637c954839e8321b8870ecdc321e14641d84c3548284cf55bc5310f7c6eb514a44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/96f1a399218f46c19371e2d5970c8f5a33362062165fac49321e7682044448197659d63bbe85ae08687f8a7f8cfd7a7af50b6d0630c2ad41c8fefb17c71dffa0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c011f858f99dbb5a30f512e405703229e62ab226748cd6e6a200ade44946a4666f920477d45167a72898abb395ee66686502d9075b9c47e99cbcb2d985722a8f"} build_url:https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/RU1QOYzAR1uohr4aJsWT0g/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/Autoland/sha512/9bdc48487284c4fbedc43c667b5a6110924aad661cdf7e206ed7491fad9106637c954839e8321b8870ecdc321e14641d84c3548284cf55bc5310f7c6eb514a44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/96f1a399218f46c19371e2d5970c8f5a33362062165fac49321e7682044448197659d63bbe85ae08687f8a7f8cfd7a7af50b6d0630c2ad41c8fefb17c71dffa0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c011f858f99dbb5a30f512e405703229e62ab226748cd6e6a200ade44946a4666f920477d45167a72898abb395ee66686502d9075b9c47e99cbcb2d985722a8f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 02:56:26.918515) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 02:56:26.918894) ========= 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=0333a256a5e4f052382dd180000001b1-1476350624.744180-958234756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004390 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 02:56:27.004184) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 02:56:27.004664) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 02:56:27.005060) ========= ========= Total master_lag: 0.17 =========