builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1476203804.71 results: success (0) buildid: 20161011083447 builduid: b0c0ebcfc0cd4acdba0db9a5bf638287 revision: d1f7b01c80f80c00a5c0f90278afb9291c8a46a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 09:36:44.712143) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 09:36:44.712605) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 09:36:44.712893) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 09:36:44.728459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 09:36:44.728759) ========= 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-1476203718.910284-2042620551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-11 09:36:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-10-11 09:36:45 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.111986 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 09:36:44.859053) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 09:36:44.859384) ========= 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-1476203718.910284-2042620551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019672 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 09:36:44.910048) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 09:36:44.910361) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev d1f7b01c80f80c00a5c0f90278afb9291c8a46a4 --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 d1f7b01c80f80c00a5c0f90278afb9291c8a46a4 --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-1476203718.910284-2042620551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-11 09:36:45,622 truncating revision to first 12 chars 2016-10-11 09:36:45,622 Setting DEBUG logging. 2016-10-11 09:36:45,622 attempt 1/10 2016-10-11 09:36:45,622 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/d1f7b01c80f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 09:36:46,218 unpacking tar archive at: autoland-d1f7b01c80f8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.993805 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 09:36:45.917725) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 09:36:45.918026) ========= script_repo_revision: d1f7b01c80f80c00a5c0f90278afb9291c8a46a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 09:36:45.918450) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 09:36:45.918729) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 09:36:45.927839) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-11 09:36:45.928120) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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-1476203718.910284-2042620551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:36:46 INFO - MultiFileLogger online at 20161011 09:36:46 in /builds/slave/test 09:36:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 09:36:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:36:46 INFO - {'append_to_log': False, 09:36:46 INFO - 'base_work_dir': '/builds/slave/test', 09:36:46 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 09:36:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:36:46 INFO - 'branch': 'Autoland-Non-PGO', 09:36:46 INFO - 'buildbot_json_path': 'buildprops.json', 09:36:46 INFO - 'config_files': ('talos/linux_config.py',), 09:36:46 INFO - 'default_actions': ('clobber', 09:36:46 INFO - 'read-buildbot-config', 09:36:46 INFO - 'download-and-extract', 09:36:46 INFO - 'populate-webroot', 09:36:46 INFO - 'create-virtualenv', 09:36:46 INFO - 'install', 09:36:46 INFO - 'run-tests'), 09:36:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:36:46 INFO - 'download_minidump_stackwalk': True, 09:36:46 INFO - 'download_symbols': 'ondemand', 09:36:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:36:46 INFO - 'tooltool.py': '/tools/tooltool.py', 09:36:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:36:46 INFO - '/tools/misc-python/virtualenv.py')}, 09:36:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:36:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:36:46 INFO - 'installer_path': 'installer.exe', 09:36:46 INFO - 'log_level': 'info', 09:36:46 INFO - 'log_name': 'talos', 09:36:46 INFO - 'log_to_console': True, 09:36:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:36:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:36:46 INFO - 'opt_config_files': (), 09:36:46 INFO - 'pip_index': False, 09:36:46 INFO - 'sps_profile': False, 09:36:46 INFO - 'sps_profile_interval': 0, 09:36:46 INFO - 'suite': 'dromaeojs', 09:36:46 INFO - 'system_bits': '32', 09:36:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:36:46 INFO - 'title': 'talos-linux64-ix-017', 09:36:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:36:46 INFO - 'use_talos_json': True, 09:36:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:36:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:36:46 INFO - 'work_dir': 'build'} 09:36:46 INFO - [mozharness: 2016-10-11 16:36:46.741716Z] Running clobber step. 09:36:46 INFO - Running pre-action listener: _resource_record_pre_action 09:36:46 INFO - Running main action method: clobber 09:36:46 INFO - rmtree: /builds/slave/test/build 09:36:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:36:47 INFO - Running post-action listener: _resource_record_post_action 09:36:47 INFO - [mozharness: 2016-10-11 16:36:47.205707Z] Finished clobber step (success) 09:36:47 INFO - [mozharness: 2016-10-11 16:36:47.205806Z] Running read-buildbot-config step. 09:36:47 INFO - Running pre-action listener: _resource_record_pre_action 09:36:47 INFO - Running main action method: read_buildbot_config 09:36:47 INFO - Using buildbot properties: 09:36:47 INFO - { 09:36:47 INFO - "project": "", 09:36:47 INFO - "product": "firefox", 09:36:47 INFO - "script_repo_revision": "production", 09:36:47 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 09:36:47 INFO - "repository": "", 09:36:47 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 09:36:47 INFO - "buildid": "20161011083447", 09:36:47 INFO - "pgo_build": "False", 09:36:47 INFO - "basedir": "/builds/slave/test", 09:36:47 INFO - "buildnumber": 757, 09:36:47 INFO - "slavename": "talos-linux64-ix-017", 09:36:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:36:47 INFO - "platform": "ubuntu64_hw", 09:36:47 INFO - "scheduler": "tests-autoland-linux64-talos", 09:36:47 INFO - "branch": "autoland", 09:36:47 INFO - "repo_path": "integration/autoland", 09:36:47 INFO - "revision": "d1f7b01c80f80c00a5c0f90278afb9291c8a46a4", 09:36:47 INFO - "stage_platform": "linux64", 09:36:47 INFO - "builduid": "b0c0ebcfc0cd4acdba0db9a5bf638287", 09:36:47 INFO - "slavebuilddir": "test" 09:36:47 INFO - } 09:36:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:36:47 INFO - Running post-action listener: _resource_record_post_action 09:36:47 INFO - [mozharness: 2016-10-11 16:36:47.208536Z] Finished read-buildbot-config step (success) 09:36:47 INFO - [mozharness: 2016-10-11 16:36:47.208625Z] Running download-and-extract step. 09:36:47 INFO - Running pre-action listener: _resource_record_pre_action 09:36:47 INFO - Running main action method: download_and_extract 09:36:47 INFO - mkdir: /builds/slave/test/build/tests 09:36:47 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')]} 09:36:47 INFO - trying https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:36:47 INFO - Downloading https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/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 09:36:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/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 09:36:47 INFO - Downloaded 1361 bytes. 09:36:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:36:47 INFO - Using the following test package requirements: 09:36:47 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:36:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:36:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:36:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:47 INFO - u'jsshell-linux-x86_64.zip'], 09:36:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:36:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:36:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:36:47 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:36:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:36:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:36:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:36:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:36:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:36:47 INFO - Fetch https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:36:48 INFO - Http code: 200 09:36:48 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 09:36:48 INFO - x-amz-cf-id: nNTeuv9F6ix5sy4afFDQ6q4X-2cB7rJTHMK-0z6f_v58K_YsY0q4Aw== 09:36:48 INFO - x-amz-version-id: L0K56bU6AguO684VwnL.MJ9LV8ebypid 09:36:49 INFO - Expected file size: 20529234 09:36:49 INFO - Obtained file size: 20529234 09:36:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:36:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:36:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:36:53 INFO - Fetch https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:36:54 INFO - Http code: 200 09:36:54 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 09:36:54 INFO - x-amz-cf-id: CqtM5dTfcYek7Z2YeJ2_sBTAN8qUYXBm0ceR1SMhOyzsvSbm6DqVWA== 09:36:54 INFO - x-amz-version-id: L0K56bU6AguO684VwnL.MJ9LV8ebypid 09:36:54 INFO - Expected file size: 20529234 09:36:54 INFO - Obtained file size: 20529234 09:36:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:36:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:36:59 INFO - Fetch https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:36:59 INFO - Http code: 200 09:36:59 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 09:36:59 INFO - x-amz-cf-id: Ws38Etz7kJ6MAnoGd_4E_CL17RWTTUp2rBjfSBVzJcygGGMfQ1RfFg== 09:36:59 INFO - x-amz-version-id: JUUAc8WwZnWIQsgSKLNbZt6OLFNAKvU_ 09:37:00 INFO - Expected file size: 14409006 09:37:00 INFO - Obtained file size: 14409006 09:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:00 INFO - trying https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:37:00 INFO - Downloading https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/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 09:37:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/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 09:37:03 INFO - Downloaded 55898181 bytes. 09:37:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:37:03 INFO - mkdir: /builds/slave/test/properties 09:37:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:37:03 INFO - Writing to file /builds/slave/test/properties/build_url 09:37:03 INFO - Contents: 09:37:03 INFO - build_url:https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:37:03 INFO - Running post-action listener: _resource_record_post_action 09:37:03 INFO - Running post-action listener: set_extra_try_arguments 09:37:03 INFO - [mozharness: 2016-10-11 16:37:03.904682Z] Finished download-and-extract step (success) 09:37:03 INFO - [mozharness: 2016-10-11 16:37:03.904906Z] Running populate-webroot step. 09:37:03 INFO - Running pre-action listener: _resource_record_pre_action 09:37:03 INFO - Running main action method: populate_webroot 09:37:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:37:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:37:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:37:03 INFO - '--tppagecycles', 09:37:03 INFO - '7'], 09:37:03 INFO - 'tests': ['tsvgm']}}, 09:37:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:37:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:37:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:37:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:37:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:37:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:37:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:03 INFO - 'talos_options': ['--disable-e10s'], 09:37:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:37:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:37:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:03 INFO - 'talos_options': ['--disable-e10s'], 09:37:03 INFO - 'tests': ['damp', 'tps']}, 09:37:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:03 INFO - 'tests': ['damp', 'tps']}, 09:37:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:37:03 INFO - 'tests': ['dromaeo_dom']}, 09:37:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:37:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:37:03 INFO - 'tests': ['basic_compositor_video']}, 09:37:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:37:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:37:03 INFO - 'tests': ['a11yr', 09:37:03 INFO - 'ts_paint', 09:37:03 INFO - 'tpaint', 09:37:03 INFO - 'sessionrestore', 09:37:03 INFO - 'sessionrestore_no_auto_restore', 09:37:03 INFO - 'tabpaint']}, 09:37:03 INFO - 'other-e10s': {'tests': ['a11yr', 09:37:03 INFO - 'ts_paint', 09:37:03 INFO - 'tpaint', 09:37:03 INFO - 'sessionrestore', 09:37:03 INFO - 'sessionrestore_no_auto_restore', 09:37:03 INFO - 'tabpaint']}, 09:37:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:37:03 INFO - 'ts_paint', 09:37:03 INFO - 'tpaint', 09:37:03 INFO - 'sessionrestore', 09:37:03 INFO - 'sessionrestore_no_auto_restore', 09:37:03 INFO - 'tabpaint']}, 09:37:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:37:03 INFO - 'ts_paint', 09:37:03 INFO - 'tpaint', 09:37:03 INFO - 'sessionrestore', 09:37:03 INFO - 'sessionrestore_no_auto_restore', 09:37:03 INFO - 'tabpaint']}, 09:37:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:37:03 INFO - 'tests': ['a11yr', 09:37:03 INFO - 'ts_paint', 09:37:03 INFO - 'tpaint', 09:37:03 INFO - 'sessionrestore', 09:37:03 INFO - 'sessionrestore_no_auto_restore', 09:37:03 INFO - 'tabpaint']}, 09:37:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:37:03 INFO - 'tests': ['a11yr', 09:37:03 INFO - 'ts_paint', 09:37:03 INFO - 'tpaint', 09:37:03 INFO - 'sessionrestore', 09:37:03 INFO - 'sessionrestore_no_auto_restore', 09:37:03 INFO - 'tabpaint']}, 09:37:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:37:03 INFO - 'tests': ['tsvgx', 09:37:03 INFO - 'tsvgr_opacity', 09:37:03 INFO - 'tart', 09:37:03 INFO - 'tscrollx', 09:37:03 INFO - 'cart']}, 09:37:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:37:03 INFO - 'tsvgr_opacity', 09:37:03 INFO - 'tart', 09:37:03 INFO - 'tscrollx', 09:37:03 INFO - 'cart']}, 09:37:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:03 INFO - 'talos_options': ['--disable-e10s'], 09:37:03 INFO - 'tests': ['tp5o']}, 09:37:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:03 INFO - 'tests': ['tp5o']}, 09:37:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:03 INFO - 'talos_options': ['--disable-e10s', 09:37:03 INFO - '--xperf_path', 09:37:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:37:03 INFO - 'tests': ['tp5n']}, 09:37:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:03 INFO - 'talos_options': ['--xperf_path', 09:37:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:37:03 INFO - 'tests': ['tp5n']}}, 09:37:03 INFO - 'talos.zip': {'path': '', 09:37:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:37:03 INFO - Running post-action listener: _resource_record_post_action 09:37:03 INFO - [mozharness: 2016-10-11 16:37:03.921853Z] Finished populate-webroot step (success) 09:37:03 INFO - [mozharness: 2016-10-11 16:37:03.921941Z] Running create-virtualenv step. 09:37:03 INFO - Running pre-action listener: _resource_record_pre_action 09:37:03 INFO - Running main action method: create_virtualenv 09:37:03 INFO - Creating virtualenv /builds/slave/test/build/venv 09:37:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:37:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:37:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:37:04 INFO - Using real prefix '/usr' 09:37:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:37:04 INFO - Installing distribute.............................................................................................................................................................................................done. 09:37:06 INFO - Installing pip.................done. 09:37:06 INFO - Return code: 0 09:37:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:37:06 INFO - Reading from file tmpfile_stdout 09:37:06 INFO - Output received: 09:37:06 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) 09:37:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1367fe6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151bf60>, '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 0x151cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151d1d0>, '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-1476203718.910284-2042620551', '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 09:37:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:37:06 INFO - Using env: {'DISPLAY': ':0', 09:37:06 INFO - 'HOME': '/home/cltbld', 09:37:06 INFO - 'LANG': 'en_US.UTF-8', 09:37:06 INFO - 'LANGUAGE': 'en_US:en', 09:37:06 INFO - 'LOGNAME': 'cltbld', 09:37:06 INFO - 'MAIL': '/var/mail/cltbld', 09:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:06 INFO - 'MOZ_NO_REMOTE': '1', 09:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:06 INFO - 'NO_EM_RESTART': '1', 09:37:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:06 INFO - 'PWD': '/builds/slave/test', 09:37:06 INFO - 'SHELL': '/bin/bash', 09:37:06 INFO - 'SHLVL': '1', 09:37:06 INFO - 'TERM': 'linux', 09:37:06 INFO - 'TMOUT': '86400', 09:37:06 INFO - 'USER': 'cltbld', 09:37:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476203718.910284-2042620551', 09:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:06 INFO - '_': '/tools/buildbot/bin/python'} 09:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:37:06 INFO - Cleaning up... 09:37:06 INFO - Return code: 0 09:37:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1367fe6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151bf60>, '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 0x151cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151d1d0>, '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-1476203718.910284-2042620551', '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 09:37:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:37:06 INFO - Using env: {'DISPLAY': ':0', 09:37:06 INFO - 'HOME': '/home/cltbld', 09:37:06 INFO - 'LANG': 'en_US.UTF-8', 09:37:06 INFO - 'LANGUAGE': 'en_US:en', 09:37:06 INFO - 'LOGNAME': 'cltbld', 09:37:06 INFO - 'MAIL': '/var/mail/cltbld', 09:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:06 INFO - 'MOZ_NO_REMOTE': '1', 09:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:06 INFO - 'NO_EM_RESTART': '1', 09:37:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:06 INFO - 'PWD': '/builds/slave/test', 09:37:06 INFO - 'SHELL': '/bin/bash', 09:37:06 INFO - 'SHLVL': '1', 09:37:06 INFO - 'TERM': 'linux', 09:37:06 INFO - 'TMOUT': '86400', 09:37:06 INFO - 'USER': 'cltbld', 09:37:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476203718.910284-2042620551', 09:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:06 INFO - '_': '/tools/buildbot/bin/python'} 09:37:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:07 INFO - Downloading/unpacking psutil>=3.1.1 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:37:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:09 INFO - Installing collected packages: psutil 09:37:09 INFO - Running setup.py install for psutil 09:37:09 INFO - building 'psutil._psutil_linux' extension 09:37:09 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 09:37:09 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 09:37:09 INFO - building 'psutil._psutil_posix' extension 09:37:09 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 09:37:09 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 09:37:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:09 INFO - Successfully installed psutil 09:37:09 INFO - Cleaning up... 09:37:09 INFO - Return code: 0 09:37:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:37: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')]} 09:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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')]} 09:37:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1367fe6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151bf60>, '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 0x151cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151d1d0>, '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-1476203718.910284-2042620551', '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 09:37: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:37: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 mozsystemmonitor==0.3 09:37:09 INFO - Using env: {'DISPLAY': ':0', 09:37:09 INFO - 'HOME': '/home/cltbld', 09:37:09 INFO - 'LANG': 'en_US.UTF-8', 09:37:09 INFO - 'LANGUAGE': 'en_US:en', 09:37:09 INFO - 'LOGNAME': 'cltbld', 09:37:09 INFO - 'MAIL': '/var/mail/cltbld', 09:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:09 INFO - 'MOZ_NO_REMOTE': '1', 09:37:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:09 INFO - 'NO_EM_RESTART': '1', 09:37:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:09 INFO - 'PWD': '/builds/slave/test', 09:37:09 INFO - 'SHELL': '/bin/bash', 09:37:09 INFO - 'SHLVL': '1', 09:37:09 INFO - 'TERM': 'linux', 09:37:09 INFO - 'TMOUT': '86400', 09:37:09 INFO - 'USER': 'cltbld', 09:37:09 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476203718.910284-2042620551', 09:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:09 INFO - '_': '/tools/buildbot/bin/python'} 09:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:37:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:37:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:37:11 INFO - Installing collected packages: mozsystemmonitor 09:37:11 INFO - Running setup.py install for mozsystemmonitor 09:37:12 INFO - Successfully installed mozsystemmonitor 09:37:12 INFO - Cleaning up... 09:37:12 INFO - Return code: 0 09:37:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:37: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')]} 09:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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')]} 09:37:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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', '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 0x7f1367fe6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151bf60>, '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 0x151cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151d1d0>, '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-1476203718.910284-2042620551', '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 09:37: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:37: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 jsonschema==2.5.1 09:37:12 INFO - Using env: {'DISPLAY': ':0', 09:37:12 INFO - 'HOME': '/home/cltbld', 09:37:12 INFO - 'LANG': 'en_US.UTF-8', 09:37:12 INFO - 'LANGUAGE': 'en_US:en', 09:37:12 INFO - 'LOGNAME': 'cltbld', 09:37:12 INFO - 'MAIL': '/var/mail/cltbld', 09:37:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:12 INFO - 'MOZ_NO_REMOTE': '1', 09:37:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:12 INFO - 'NO_EM_RESTART': '1', 09:37:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:12 INFO - 'PWD': '/builds/slave/test', 09:37:12 INFO - 'SHELL': '/bin/bash', 09:37:12 INFO - 'SHLVL': '1', 09:37:12 INFO - 'TERM': 'linux', 09:37:12 INFO - 'TMOUT': '86400', 09:37:12 INFO - 'USER': 'cltbld', 09:37:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476203718.910284-2042620551', 09:37:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:12 INFO - '_': '/tools/buildbot/bin/python'} 09:37:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:12 INFO - Downloading/unpacking jsonschema==2.5.1 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:37:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37:14 INFO - Downloading functools32-3.2.3-2.tar.gz 09:37:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:37:14 INFO - warning: no files found matching '*.txt' 09:37:14 INFO - no previously-included directories found matching 'build' 09:37:14 INFO - no previously-included directories found matching 'dist' 09:37:14 INFO - no previously-included directories found matching '.git*' 09:37:14 INFO - Installing collected packages: jsonschema, functools32 09:37:14 INFO - Running setup.py install for functools32 09:37:14 INFO - warning: no files found matching '*.txt' 09:37:14 INFO - no previously-included directories found matching 'build' 09:37:14 INFO - no previously-included directories found matching 'dist' 09:37:14 INFO - no previously-included directories found matching '.git*' 09:37:14 INFO - Successfully installed jsonschema functools32 09:37:14 INFO - Cleaning up... 09:37:14 INFO - Return code: 0 09:37:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1367fe6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151bf60>, '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 0x151cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151d1d0>, '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-1476203718.910284-2042620551', '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 09:37:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:37:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:37:14 INFO - Using env: {'DISPLAY': ':0', 09:37:14 INFO - 'HOME': '/home/cltbld', 09:37:14 INFO - 'LANG': 'en_US.UTF-8', 09:37:14 INFO - 'LANGUAGE': 'en_US:en', 09:37:14 INFO - 'LOGNAME': 'cltbld', 09:37:14 INFO - 'MAIL': '/var/mail/cltbld', 09:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:14 INFO - 'MOZ_NO_REMOTE': '1', 09:37:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:14 INFO - 'NO_EM_RESTART': '1', 09:37:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:14 INFO - 'PWD': '/builds/slave/test', 09:37:14 INFO - 'SHELL': '/bin/bash', 09:37:14 INFO - 'SHLVL': '1', 09:37:14 INFO - 'TERM': 'linux', 09:37:14 INFO - 'TMOUT': '86400', 09:37:14 INFO - 'USER': 'cltbld', 09:37:14 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476203718.910284-2042620551', 09:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:14 INFO - '_': '/tools/buildbot/bin/python'} 09:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:37:15 INFO - Cleaning up... 09:37:15 INFO - Return code: 0 09:37:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:37:15 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')]} 09:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:15 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')]} 09:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:15 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 0x7f1367fe6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151bf60>, '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 0x151cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151d1d0>, '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-1476203718.910284-2042620551', '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 09:37:15 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 09:37:15 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 09:37:15 INFO - Using env: {'DISPLAY': ':0', 09:37:15 INFO - 'HOME': '/home/cltbld', 09:37:15 INFO - 'LANG': 'en_US.UTF-8', 09:37:15 INFO - 'LANGUAGE': 'en_US:en', 09:37:15 INFO - 'LOGNAME': 'cltbld', 09:37:15 INFO - 'MAIL': '/var/mail/cltbld', 09:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:15 INFO - 'MOZ_NO_REMOTE': '1', 09:37:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:15 INFO - 'NO_EM_RESTART': '1', 09:37:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:15 INFO - 'PWD': '/builds/slave/test', 09:37:15 INFO - 'SHELL': '/bin/bash', 09:37:15 INFO - 'SHLVL': '1', 09:37:15 INFO - 'TERM': 'linux', 09:37:15 INFO - 'TMOUT': '86400', 09:37:15 INFO - 'USER': 'cltbld', 09:37:15 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476203718.910284-2042620551', 09:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:15 INFO - '_': '/tools/buildbot/bin/python'} 09:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:15 INFO - Downloading/unpacking blobuploader==1.2.4 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37:17 INFO - Downloading blobuploader-1.2.4.tar.gz 09:37:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:37:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:37:17 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 09:37:17 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 09:37:17 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 09:37:17 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 09:37:17 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 09:37:17 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 09:37:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:37:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:37:18 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 09:37:18 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 09:37:18 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 09:37:18 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 09:37:18 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 09:37:18 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 09:37:18 INFO - Downloading docopt-0.6.1.tar.gz 09:37:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:37:18 INFO - Installing collected packages: blobuploader, requests, docopt 09:37:18 INFO - Running setup.py install for blobuploader 09:37:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:37:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:37:18 INFO - Running setup.py install for requests 09:37:18 INFO - Running setup.py install for docopt 09:37:18 INFO - Successfully installed blobuploader requests docopt 09:37:18 INFO - Cleaning up... 09:37:18 INFO - Return code: 0 09:37:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:18 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 0x7f1367fe6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151bf60>, '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 0x151cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151d1d0>, '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-1476203718.910284-2042620551', '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 09:37:18 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 09:37:18 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 09:37:18 INFO - Using env: {'DISPLAY': ':0', 09:37:18 INFO - 'HOME': '/home/cltbld', 09:37:18 INFO - 'LANG': 'en_US.UTF-8', 09:37:18 INFO - 'LANGUAGE': 'en_US:en', 09:37:18 INFO - 'LOGNAME': 'cltbld', 09:37:18 INFO - 'MAIL': '/var/mail/cltbld', 09:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:18 INFO - 'MOZ_NO_REMOTE': '1', 09:37:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:18 INFO - 'NO_EM_RESTART': '1', 09:37:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:18 INFO - 'PWD': '/builds/slave/test', 09:37:18 INFO - 'SHELL': '/bin/bash', 09:37:18 INFO - 'SHLVL': '1', 09:37:18 INFO - 'TERM': 'linux', 09:37:18 INFO - 'TMOUT': '86400', 09:37:18 INFO - 'USER': 'cltbld', 09:37:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476203718.910284-2042620551', 09:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:18 INFO - '_': '/tools/buildbot/bin/python'} 09:37:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:37:19 INFO - Running setup.py (path:/tmp/pip-DkVLxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:37:19 INFO - Running setup.py (path:/tmp/pip-dalMUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:37:19 INFO - Running setup.py (path:/tmp/pip-HV5d0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:37:19 INFO - Running setup.py (path:/tmp/pip-GKG9SQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:37:19 INFO - Running setup.py (path:/tmp/pip-TL7yFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:37:19 INFO - Running setup.py (path:/tmp/pip-2LQOl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:37:19 INFO - Running setup.py (path:/tmp/pip-GtnuiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:37:19 INFO - Running setup.py (path:/tmp/pip-gmeY5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:37:19 INFO - Running setup.py (path:/tmp/pip-hdNxZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:37:19 INFO - Running setup.py (path:/tmp/pip-hrDpUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:37:19 INFO - Running setup.py (path:/tmp/pip-GJamMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:37:19 INFO - Running setup.py (path:/tmp/pip-Up3NeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:37:19 INFO - Running setup.py (path:/tmp/pip-lS3AmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:37:20 INFO - Running setup.py (path:/tmp/pip-mLMYKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:20 INFO - Running setup.py (path:/tmp/pip-fEQIVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:37:20 INFO - Running setup.py (path:/tmp/pip-2jiXTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:37:20 INFO - Running setup.py (path:/tmp/pip-E7iE9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:37:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:37:20 INFO - Running setup.py install for manifestparser 09:37:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:37:20 INFO - Running setup.py install for mozcrash 09:37:20 INFO - Running setup.py install for mozdebug 09:37:20 INFO - Running setup.py install for mozdevice 09:37:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:37:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:37:20 INFO - Running setup.py install for mozfile 09:37:20 INFO - Running setup.py install for mozhttpd 09:37:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:37:20 INFO - Running setup.py install for mozinfo 09:37:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:37:21 INFO - Running setup.py install for mozInstall 09:37:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:37:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:37:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:37:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:37:21 INFO - Running setup.py install for mozleak 09:37:21 INFO - Running setup.py install for mozlog 09:37:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:37:21 INFO - Running setup.py install for moznetwork 09:37:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:37:21 INFO - Running setup.py install for mozprocess 09:37:21 INFO - Running setup.py install for mozprofile 09:37:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:37:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:37:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:37:21 INFO - Running setup.py install for mozrunner 09:37:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:37:21 INFO - Running setup.py install for mozscreenshot 09:37:21 INFO - Running setup.py install for moztest 09:37:22 INFO - Running setup.py install for mozversion 09:37:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:37:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:37:22 INFO - Cleaning up... 09:37:22 INFO - Return code: 0 09:37:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:37:22 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')]} 09:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:22 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')]} 09:37:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:22 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 0x7f1367fe6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151bf60>, '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 0x151cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151d1d0>, '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-1476203718.910284-2042620551', '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 09:37:22 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 09:37:22 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 09:37:22 INFO - Using env: {'DISPLAY': ':0', 09:37:22 INFO - 'HOME': '/home/cltbld', 09:37:22 INFO - 'LANG': 'en_US.UTF-8', 09:37:22 INFO - 'LANGUAGE': 'en_US:en', 09:37:22 INFO - 'LOGNAME': 'cltbld', 09:37:22 INFO - 'MAIL': '/var/mail/cltbld', 09:37:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:22 INFO - 'MOZ_NO_REMOTE': '1', 09:37:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:22 INFO - 'NO_EM_RESTART': '1', 09:37:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:22 INFO - 'PWD': '/builds/slave/test', 09:37:22 INFO - 'SHELL': '/bin/bash', 09:37:22 INFO - 'SHLVL': '1', 09:37:22 INFO - 'TERM': 'linux', 09:37:22 INFO - 'TMOUT': '86400', 09:37:22 INFO - 'USER': 'cltbld', 09:37:22 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476203718.910284-2042620551', 09:37:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:22 INFO - '_': '/tools/buildbot/bin/python'} 09:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:37:22 INFO - Running setup.py (path:/tmp/pip-X7eW6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:37:22 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)) 09:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:37:22 INFO - Running setup.py (path:/tmp/pip-yJbtT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:37:22 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)) 09:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:37:22 INFO - Running setup.py (path:/tmp/pip-bPeOP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:37:22 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)) 09:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:37:22 INFO - Running setup.py (path:/tmp/pip-Oq3VAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:37:22 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)) 09:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:37:22 INFO - Running setup.py (path:/tmp/pip-VTDi1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:37:22 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)) 09:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:37:22 INFO - Running setup.py (path:/tmp/pip-Fd4hgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:37:22 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)) 09:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:37:22 INFO - Running setup.py (path:/tmp/pip-NVMBfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:37:22 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)) 09:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:37:22 INFO - Running setup.py (path:/tmp/pip-hx1EhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:37:22 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)) 09:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:37:22 INFO - Running setup.py (path:/tmp/pip-5G8dwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:37:23 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)) 09:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:37:23 INFO - Running setup.py (path:/tmp/pip-AO2VpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:37:23 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)) 09:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:37:23 INFO - Running setup.py (path:/tmp/pip-d0ScJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:37:23 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)) 09:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:37:23 INFO - Running setup.py (path:/tmp/pip-iWZ7zE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:37:23 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)) 09:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:37:23 INFO - Running setup.py (path:/tmp/pip-TCOVDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:37:23 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)) 09:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:37:23 INFO - Running setup.py (path:/tmp/pip-F4K3jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:37:23 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)) 09:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:23 INFO - Running setup.py (path:/tmp/pip-XbfyIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:23 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)) 09:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:37:23 INFO - Running setup.py (path:/tmp/pip-Icc3DJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:37:23 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)) 09:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:37:23 INFO - Running setup.py (path:/tmp/pip-9Ty_yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:37:23 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)) 09:37:23 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)) 09:37:23 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)) 09:37:23 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)) 09:37:23 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)) 09:37:23 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)) 09:37:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:37:23 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 09:37:23 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 09:37:23 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 09:37:23 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 09:37:23 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 09:37:23 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 09:37:25 INFO - Downloading blessings-1.6.tar.gz 09:37:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:37:25 INFO - Installing collected packages: blessings 09:37:25 INFO - Running setup.py install for blessings 09:37:25 INFO - Successfully installed blessings 09:37:25 INFO - Cleaning up... 09:37:25 INFO - Return code: 0 09:37:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:37:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:37:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:37:25 INFO - Reading from file tmpfile_stdout 09:37:25 INFO - Current package versions: 09:37:25 INFO - argparse == 1.2.1 09:37:25 INFO - blessings == 1.6 09:37:25 INFO - blobuploader == 1.2.4 09:37:25 INFO - docopt == 0.6.1 09:37:25 INFO - functools32 == 3.2.3-2 09:37:25 INFO - jsonschema == 2.5.1 09:37:25 INFO - manifestparser == 1.1 09:37:25 INFO - mozInstall == 1.12 09:37:25 INFO - mozcrash == 0.17 09:37:25 INFO - mozdebug == 0.1 09:37:25 INFO - mozdevice == 0.48 09:37:25 INFO - mozfile == 1.2 09:37:25 INFO - mozhttpd == 0.7 09:37:25 INFO - mozinfo == 0.9 09:37:25 INFO - mozleak == 0.1 09:37:25 INFO - mozlog == 3.4 09:37:25 INFO - moznetwork == 0.27 09:37:25 INFO - mozprocess == 0.23 09:37:25 INFO - mozprofile == 0.28 09:37:25 INFO - mozrunner == 6.12 09:37:25 INFO - mozscreenshot == 0.1 09:37:25 INFO - mozsystemmonitor == 0.3 09:37:25 INFO - moztest == 0.7 09:37:25 INFO - mozversion == 1.4 09:37:25 INFO - psutil == 3.1.1 09:37:25 INFO - requests == 1.2.3 09:37:25 INFO - wsgiref == 0.1.2 09:37:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:26 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 0x7f1367fe6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151bf60>, '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 0x151cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151d1d0>, '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-1476203718.910284-2042620551', '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 09:37:26 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 09:37:26 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 09:37:26 INFO - Using env: {'DISPLAY': ':0', 09:37:26 INFO - 'HOME': '/home/cltbld', 09:37:26 INFO - 'LANG': 'en_US.UTF-8', 09:37:26 INFO - 'LANGUAGE': 'en_US:en', 09:37:26 INFO - 'LOGNAME': 'cltbld', 09:37:26 INFO - 'MAIL': '/var/mail/cltbld', 09:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:26 INFO - 'MOZ_NO_REMOTE': '1', 09:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:26 INFO - 'NO_EM_RESTART': '1', 09:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:26 INFO - 'PWD': '/builds/slave/test', 09:37:26 INFO - 'SHELL': '/bin/bash', 09:37:26 INFO - 'SHLVL': '1', 09:37:26 INFO - 'TERM': 'linux', 09:37:26 INFO - 'TMOUT': '86400', 09:37:26 INFO - 'USER': 'cltbld', 09:37:26 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476203718.910284-2042620551', 09:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:26 INFO - '_': '/tools/buildbot/bin/python'} 09:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:26 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)) 09:37:26 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)) 09:37:26 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)) 09:37:26 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)) 09:37:26 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)) 09:37:26 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)) 09:37:26 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)) 09:37:26 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)) 09:37:26 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)) 09:37:26 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)) 09:37:26 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)) 09:37:26 INFO - Cleaning up... 09:37:26 INFO - Return code: 0 09:37:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:37:26 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')]} 09:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:26 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')]} 09:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:26 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 0x7f1367fe6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151bf60>, '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 0x151cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151d1d0>, '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-1476203718.910284-2042620551', '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 09:37:26 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 09:37:26 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 09:37:26 INFO - Using env: {'DISPLAY': ':0', 09:37:26 INFO - 'HOME': '/home/cltbld', 09:37:26 INFO - 'LANG': 'en_US.UTF-8', 09:37:26 INFO - 'LANGUAGE': 'en_US:en', 09:37:26 INFO - 'LOGNAME': 'cltbld', 09:37:26 INFO - 'MAIL': '/var/mail/cltbld', 09:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:26 INFO - 'MOZ_NO_REMOTE': '1', 09:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:26 INFO - 'NO_EM_RESTART': '1', 09:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:26 INFO - 'PWD': '/builds/slave/test', 09:37:26 INFO - 'SHELL': '/bin/bash', 09:37:26 INFO - 'SHLVL': '1', 09:37:26 INFO - 'TERM': 'linux', 09:37:26 INFO - 'TMOUT': '86400', 09:37:26 INFO - 'USER': 'cltbld', 09:37:26 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476203718.910284-2042620551', 09:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:26 INFO - '_': '/tools/buildbot/bin/python'} 09:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:37:26 INFO - Cleaning up... 09:37:26 INFO - Return code: 0 09:37:26 INFO - Running post-action listener: _resource_record_post_action 09:37:26 INFO - Running post-action listener: _start_resource_monitoring 09:37:26 INFO - Starting resource monitoring. 09:37:26 INFO - [mozharness: 2016-10-11 16:37:26.511824Z] Finished create-virtualenv step (success) 09:37:26 INFO - [mozharness: 2016-10-11 16:37:26.512332Z] Running install step. 09:37:26 INFO - Running pre-action listener: _resource_record_pre_action 09:37:26 INFO - Running main action method: install 09:37:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:37:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:37:26 INFO - Reading from file tmpfile_stdout 09:37:26 INFO - Detecting whether we're running mozinstall >=1.0... 09:37:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:37:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:37:26 INFO - Reading from file tmpfile_stdout 09:37:26 INFO - Output received: 09:37:26 INFO - Usage: mozinstall [options] installer 09:37:26 INFO - Options: 09:37:26 INFO - -h, --help show this help message and exit 09:37:26 INFO - -d DEST, --destination=DEST 09:37:26 INFO - Directory to install application into. [default: 09:37:26 INFO - "/builds/slave/test"] 09:37:26 INFO - --app=APP Application being installed. [default: firefox] 09:37:26 INFO - mkdir: /builds/slave/test/build/application 09:37:26 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'] 09:37:26 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 09:37:42 INFO - Reading from file tmpfile_stdout 09:37:42 INFO - Output received: 09:37:42 INFO - /builds/slave/test/build/application/firefox/firefox 09:37:42 INFO - Running post-action listener: _resource_record_post_action 09:37:42 INFO - [mozharness: 2016-10-11 16:37:42.957864Z] Finished install step (success) 09:37:42 INFO - [mozharness: 2016-10-11 16:37:42.958107Z] Running run-tests step. 09:37:42 INFO - Running pre-action listener: _resource_record_pre_action 09:37:42 INFO - Running main action method: run_tests 09:37:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:37:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:37:42 INFO - Python 2.7.3 09:37:42 INFO - Return code: 0 09:37:42 INFO - grabbing minidump binary from tooltool 09:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:42 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151bf60>, '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 0x151cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:37:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:37:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:37:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:37:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:37:43 INFO - Return code: 0 09:37:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:37:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:37:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:37:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:37:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:37:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/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 09:37:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/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 09:37:43 INFO - Using env: {'DISPLAY': ':0', 09:37:43 INFO - 'HOME': '/home/cltbld', 09:37:43 INFO - 'LANG': 'en_US.UTF-8', 09:37:43 INFO - 'LANGUAGE': 'en_US:en', 09:37:43 INFO - 'LOGNAME': 'cltbld', 09:37:43 INFO - 'MAIL': '/var/mail/cltbld', 09:37:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:37:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:43 INFO - 'MOZ_NO_REMOTE': '1', 09:37:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:37:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:43 INFO - 'NO_EM_RESTART': '1', 09:37:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:43 INFO - 'PWD': '/builds/slave/test', 09:37:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:37:43 INFO - 'SHELL': '/bin/bash', 09:37:43 INFO - 'SHLVL': '1', 09:37:43 INFO - 'TERM': 'linux', 09:37:43 INFO - 'TMOUT': '86400', 09:37:43 INFO - 'USER': 'cltbld', 09:37:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476203718.910284-2042620551', 09:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:43 INFO - '_': '/tools/buildbot/bin/python'} 09:37:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/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 09:37:43 INFO - mozversion application_buildid: 20161011083447 09:37:43 INFO - mozversion application_changeset: d1f7b01c80f80c00a5c0f90278afb9291c8a46a4 09:37:43 INFO - mozversion application_display_name: Nightly 09:37:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:37:43 INFO - mozversion application_name: Firefox 09:37:43 INFO - mozversion application_remotingname: firefox 09:37:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:37:43 INFO - mozversion application_vendor: Mozilla 09:37:43 INFO - mozversion application_version: 52.0a1 09:37:43 INFO - mozversion platform_buildid: 20161011083447 09:37:43 INFO - mozversion platform_changeset: d1f7b01c80f80c00a5c0f90278afb9291c8a46a4 09:37:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:37:43 INFO - mozversion platform_version: 52.0a1 09:37:43 INFO - using testdate: 1476203863 09:37:43 INFO - actual date: 1476203863 09:37:43 INFO - starting webserver on 'localhost:51634' 09:37:43 INFO - SUITE-START | Running 2 tests 09:37:43 INFO - TEST-START | dromaeo_css 09:37:43 INFO - operating with platform_type : linux_ 09:37:43 INFO - Initialising browser for dromaeo_css test... 09:37:43 INFO - TEST-INFO | started process 19943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDvAfIZ/profile http://localhost:51634/getInfo.html) 09:37:47 INFO - PROCESS | 19943 | __metrics Screen width/height:1600/1200 09:37:47 INFO - PROCESS | 19943 | colorDepth:24 09:37:47 INFO - PROCESS | 19943 | Browser inner width/height: 1024/697 09:37:47 INFO - PROCESS | 19943 | __metrics 09:37:47 INFO - PROCESS | 19943 | 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" 09:37:47 INFO - PROCESS | 19943 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:37:48 INFO - PROCESS | 19943 | console.error: PushService: 09:37:48 INFO - PROCESS | 19943 | stateChangeProcessEnqueue: Error transitioning state 09:37:48 INFO - PROCESS | 19943 | UnknownError 09:37:48 INFO - TEST-INFO | 19943: exit 0 09:37:48 INFO - Browser initialized. 09:37:48 INFO - Running cycle 1/1 for dromaeo_css test... 09:37:48 INFO - TEST-INFO | started process 20025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDvAfIZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:01 INFO - PROCESS | 20025 | RSS: Main: 175788032 09:38:01 INFO - PROCESS | 20025 | 09:38:52 INFO - PROCESS | 20025 | 1476203932595 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] 09:41:05 INFO - PROCESS | 20025 | Cycle 1(1): loaded http://localhost:51634/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51634/tests/dromaeo/cssquery-ext.html) 09:41:07 INFO - PROCESS | 20025 | RSS: Main: 376188928 09:41:07 INFO - PROCESS | 20025 | 09:44:10 INFO - PROCESS | 20025 | Cycle 1(1): loaded http://localhost:51634/tests/dromaeo/cssquery-ext.html (next: http://localhost:51634/tests/dromaeo/cssquery-jquery.html) 09:44:11 INFO - PROCESS | 20025 | RSS: Main: 281227264 09:44:11 INFO - PROCESS | 20025 | 09:47:13 INFO - PROCESS | 20025 | Cycle 1(1): loaded http://localhost:51634/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51634/tests/dromaeo/cssquery-mootools.html) 09:47:14 INFO - PROCESS | 20025 | RSS: Main: 223313920 09:47:14 INFO - PROCESS | 20025 | 09:50:16 INFO - PROCESS | 20025 | Cycle 1(1): loaded http://localhost:51634/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51634/tests/dromaeo/cssquery-prototype.html) 09:50:16 INFO - PROCESS | 20025 | RSS: Main: 230662144 09:50:16 INFO - PROCESS | 20025 | 09:53:20 INFO - PROCESS | 20025 | Cycle 1(1): loaded http://localhost:51634/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51634/tests/dromaeo/cssquery-yui.html) 09:53:20 INFO - PROCESS | 20025 | RSS: Main: 222470144 09:53:20 INFO - PROCESS | 20025 | 09:56:24 INFO - PROCESS | 20025 | Cycle 1(1): loaded http://localhost:51634/tests/dromaeo/cssquery-yui.html (next: http://localhost:51634/tests/dromaeo/cssquery-dojo.html) 09:56:24 INFO - PROCESS | 20025 | RSS: Main: 314015744 09:56:24 INFO - PROCESS | 20025 | 09:56:24 INFO - PROCESS | 20025 | __start_tp_report 09:56:24 INFO - PROCESS | 20025 | _x_x_mozilla_page_load 09:56:24 INFO - PROCESS | 20025 | _x_x_mozilla_page_load_details 09:56:24 INFO - PROCESS | 20025 | |i|pagename|runs| 09:56:24 INFO - PROCESS | 20025 | |0;dojo.html;2513.8743062846856;2540.8221424500293;2577.1881857214976;2579.187555919885;2587.3402282417983;4486.6410687145035;4561.064981678756;4569.977150114249;4595.517470665583;4598.81604735811;4578.015726618784;4593.908121837561;4597.310403439477;4600.723956562609;4603.4706008809;4160.043190066287;4220.915581688364;4234.407182994383;4263.445752052229;4290.6138447539715;4253.744775313491;4283.914321713564;4286.807093680792;4288.120935208275;4291.506476755167;4184.121334519755;4192.937105943413;4213.325867861143;4228.5982831630945;4294.570542945696;4276.358546218061;4278.379634952915;4279.443672322609;4303.225419424502;4303.225419424518;4086.366613174963;4159.542450330491;4173.937390939138;4204.26425375558;4256.297710877701;4517.954820451819;4519.41247637805;4564.908701825978;4576.8626941191815;4599.425071866017;4870.05034018363;4883.4628190898975;4884.242942343943;4894.36373271476;4968.6025117990475;4792.400949881265;4844.5882100021545;4845.854624361275;4899.191633380524;4925;4572.588467037949;4627.167109920179;4635.188841952645;4668.253079507263;4685.765711714401;5049.141645920203;5049.293098966147;5050.9494905051215;5051.898962020739;5102.974485127625;4838.564529192389;4841.491643377465;4842.58837998767;4843.128236917389;4893.73084480357;4721.102990431807;4776.5701086902345;4780.235162374003;4847.442544107403;4983.377077865267;4851.369321988119;4867.367242258554;4920.6555541111775;4923.950760492421;4930.926036109461;4840;4844.15227335222;4845.515448455127;4850.054239423279;4908.092002979389;3991.2815693175507;3993.8602148924647;4096.754194748325;4131.5248746394545;4198.748075115442;3538.7522873398616;3583.8028908409765;3624.1664417184197;3625.274945011008;3660.4692319613505;4245.1934132514725;4263.488381394252;4270.850520231839;4271.5514870938105;4321.5678432157165;4925.655204135748;4927.827526036572;4928.704277743347;4935.679180853233;4985.451600323961;4170.457840480718;4172.311568591149;4213.157368526307;4214.704970652025;4228.429162063144;4368.08270263242;4421.712588681726;4437.0460351024685;4440.933385999213;4447.043885564619;4587.151376995266;4594.678372514026;4596.862094137181;4599.5400459953735;4657.278121891112;4758.928616070692;4866.780994855169;4868.391451068616;4868.561829435368;4927.704337739747;4508.729476231437;4555.31670249452;4569.931451028304;4601.217792975135;4602.125596136723;4817.494163112963;4822.590079843252;4824.986752781955;4873.6832105913;4879.536444037811;4875.731834749123;4879.316895634543;4884.877878053077;4888.755562221946;4890.266460031024;4581.610563102174;4622.560856718606;4628.490866004669;4678.625709943129;4746.121967436035;4654.185517534485;4665.04366604852;4675.976620116878;4676.859694209179;4679.344891715231;4609.377734005866;4629.629629629689;4632.25883858581;4633.86098417048;4640.118377508263;4677.76611169447;4679.9064018718755;4680.742559159279;4681.110588988081;4684.882877927943;4658.114958157939;4699.694519856198;4710.152172608963;4762.547557981986;4766.737829419415 09:56:24 INFO - PROCESS | 20025 | |1;ext.html;563.5041163775877;572.3904042195062;576.9394213607568;583.699394811672;583.7198144890452;29511.409771804552;30287.697123028764;38323.61676383235;38739.80630096853;38935.22129557414;39530.802345988304;39896.800515997376;39930;39936;39966.40050399247;7563.621818909046;7710.961445192766;7713.961430192841;7714.074311082678;7719.536827790323;7587;7691.269329413697;7696.037995250594;7716.305532502074;7750.379969602446;7750.728724494644;7790.337821285198;7793.064832220141;7793.103793063785;7794.493357931745;7738.7678369649;7757.728479503218;7775.339096176832;7783.727569535095;7786.922130778677;7577.280158384945;7638.274363935418;7652.311291983692;7653.770386888402;7657.578833164173;36741;37004.81497592522;37065.62934370649;37082;37096.629033709585;2943.735063844243;3010.653774815902;3044.634643842731;3067.432524982863;3276.918077048069;27861.86069069662;28074.298142546395;28230.71769282322;28494.857525712447;29376.265593360124;3165.2878102427;3226.4353738095974;3243.254051568129;3260.005698262029;3296.3736889991064;247302;247794;247893;248542;248868.9999999982;31590.684093159234;46380.5361946383;46628.7668561655;46739;46743;30614.081577552708;32421.351572968408;32476;32519.18702032468;32519.837400812845;12127.818082728767;12141.878581214252;12151.756964860653;12157.148999569945;12158.574449894388;11363.659090227306;11438.485268162785;11441.084713222923;11442.256253343507;11449.370284634258;7744.457887947902;7754.379649628129;7780.14418413974;7846.097698764601;7859.960700196462;3091.350816328596;3112.2841746398453;3114.7508199343997;3140.450421176285;3165.8258795766455;827.7020272701823;828.718235799831;855.461059532503;867.098217853438;931.5481991234246;24186.153484627954;25899.482010359687;26190.869045655032;26386.604200937003;26526.867365663435;872.4721543466238;915.5285028210477;935.5041827831125;951.2722767083187;975.4391225045628;13255.337233138305;13685.31573421345;13820.308984550733;13994.720105597831;14454.855451445352;292149;294030;294382;294636;295086;45739.77130114328;46320.7683961578;46322.768386158525;46335.30497042547;46364;1059.4490864750442;1081.1837063017372;1106.618216715232;1119.8936101070385;1178.9957072975976;26128.216153515426;28694.282642934093;28855.278618033877;29496.410071798015;29541.409171816875;40701;41145.38281925833;41160;41185.38221926733;41220.587794121675;278432;279822;280577;281663;281941;22208.555828883655;22796.772032279467;24401.38996525101;25473.598952057815;25519.744802551737;39556;39843;40037.59962400455;40212.3968140484;40273.798631006655;33843.830780845936;34214;34248.315033699684;34296.31407371889;34762;33621.49567756535;33649;34326.656733433345;34386.312273754884;34843.90936543816;33787.66212337845;33924.32151357008;34175.658243417245;34338.656613433544;35049;26131;28475.43049139047;29945.550816738203;30745.38509229758;30928.226794330323;24051.398715032265;24071.51856962886;24302.149424770047;24517.632235516838;24519.26442206737 09:56:24 INFO - PROCESS | 20025 | |2;jquery.html;344.0881663591482;346.9930601387972;352.62445495547234;366.5711117991949;380.8609857402049;15467.845321546782;16507.09210993395;16601.41895033674;16735.748963765524;16736.16319184042;15400.61498462539;16055.116968566754;16646.75029874553;16743.581410464743;16889.577760555992;4975.701457912528;5190.091733946563;5219.42586315505;5220.556252718524;5221.112410890158;3537.6816086552203;3684.171061511152;5050.671706339076;5149.613778966593;5150.484951504838;3853.9614603854025;3884.9028774280587;5937.406259374071;6026.126211699301;6034.064719968412;5187.481251874782;6002.339742628307;6014.639121652671;6018.007028840236;6022.096685497167;5345.33183352081;5399.136138217906;5405.081136206854;5409.323834520685;5414;12499.93750031244;12605.93697031518;12660;12745.299008554526;12765.61703148907;1809.9909500452545;1845.5109396010068;1849.9825096197171;1963.2834015584351;2071.482129467633;8749.693760718408;9158.633654653806;9416.246700263962;9716.271279654055;9832.459214743187;1695.211726547149;1729.4206440842333;1748.545378201664;1778.4664600619762;1823.2342416185234;64105.67947160281;64157;64264.67867660678;64609.67695161494;64648.353516464704;8975.057618950046;9050.909490905007;9218.953905230432;9286.72139835806;9484.90515094854;11991.940040299743;12054.975327097294;12056.457459414347;12062.396880155957;12125.151239413333;6882.931170688229;6910;6914.343137402039;7146.428285737128;7171.1394632644415;6707;6844.1444819397575;6976.064370048449;7013.649317534205;7065.364117229474;3917.238346965383;4023.8189281482405;4316.330968699856;4369.453818272716;4376.781160942004;1628.8371162883855;1673.5314112048645;1683.9242234099495;1701.5490894912857;1725.6634956183423;764.3312101910828;773.7291947818219;796.9083555391088;805.3235282362843;843.767963809945;15487.148206848506;15968.680626387639;16476.588085297724;16726.24731887068;16832.74750878738;797.9960100199462;803.9718609848627;822.272289024206;831.4803247970019;883.0242581946984;8606.784830379165;8825.735227943043;9132.543372831331;9279.62881484733;9436.169149255196;379814;382565;385048;389169;390111;68949.65525172342;70220.64889675518;70877.64561177265;71548;72933.2706672937;880.665347168072;930.8184903943666;940.4216406909838;940.4263399326542;941.6892425499568;15710.293036813142;15823.287952041956;16276.837231628006;16616;16646.50060498187;39394.2121157581;39481.80259098686;39577.604223957394;39787.99999999884;41057.1788564233;52185;52517.7374113127;53862.730686346316;54452.72773636265;54770.45229547813;7014.614196219257;7573.242675732383;7577.280158384945;7679.654415551426;7852.255958502948;8628.22345988864;10802.189835762507;10914.345139291669;10918.508667110158;11229.21395502307;8842.292616590787;9180.17378435944;9269.119433653792;9471.19494842946;9690.903090969001;4746.264329029006;9747.122758951728;9771.560279787285;10257.230707696803;10274.845877311696;9647.719562385757;10003.199744020316;10073.546690399096;10099.79800403973;10224.1820654346;7302.19675835647;7349.595772232578;7454.254574542502;7499.362554182955;7615.238476152341;8511.191436813493;9494.572744226665;9611;9626.374285671409;10061 09:56:24 INFO - PROCESS | 20025 | |3;mootools.html;1182.550630760311;1311.8622544632817;1361.734461779953;1409.337611322678;1665.092524574107;6455.612663240203;6873.415759660428;7191.748288809893;7462.626868656573;7473.6263186840715;7419.443541734365;7452.180260171391;7473.290037446447;7482.513636613617;7484.288992545713;2064.6593312103487;2089.8014688604635;2090.216168936649;2092.571022940301;2092.9058192381303;2030.4416285521452;2059.639563076463;2061.3197644777188;2082.1775398717496;2082.458560774202;2078.9792102079014;2080.365488525999;2082.0422605601366;2083.72911521502;2088.363049269972;2044.4684382060698;2047.1299697628597;2048.109072553444;2051.5281485258474;2054.1064636883;1994.481434826941;2003.9298624548217;2007.9397618071482;2019.424464027745;2049.067674208232;7431.777046688554;7529.661165247522;7530.096388433423;7532.887006694904;7534.660940257701;4250.787460626956;4368.170047690928;4379.343098535245;4432.623227025707;4442.267025940716;2741.314671332167;2852.472292625871;2910.5052141136057;2913.373624670706;2914.2277296516227;872.1714371347246;884.6328773558965;904.3307952115453;917.2020342302174;925.4632313258294;9742.415455072718;9947.502624868728;9967.45179015154;9969.90030099697;10015.298929074896;3571.6606922342335;3769.965178031711;3802.125511132455;3864.748791328611;3883.66988805949;7902.4863383879865;7917.564533950688;7920.762377128695;7923.7226697065325;7926.365890728728;4306.827726890952;4329.372241025034;4329.567043295709;4330.631896288788;4335.241332766753;3568.5896121946307;3672.779633222015;3998.9000274992777;4061.3095773718537;4066.1461093170174;3217.2439476722952;3305.7851239669344;3376.7973921564785;3389.694927456541;3393.8472768725464;1015.007469109542;1019.7399663086014;1028.681108856257;1033.7415646088477;1045.4720366215013;636.2714691678095;731.8719224135755;758.4728613613596;766.5745511241315;784.9058113026359;4840.903181936342;4905.411350637946;5092.898142037138;5120.129577971754;5220.399654039758;796.9960150199212;848.3255811629646;853.5390888920037;855.4183155454226;859.5315553023618;3247.8700851966128;3294.1599892027857;3371.544841446422;3420.401429749784;3518.595361533405;8272.958635206785;8826.602802873886;8869.201771840566;8874.245689116367;8876.911230887737;8526.65893364271;8797.164269394398;8808.91191088081;8814.559272036373;8816.294696424271;6815.931840681629;7046.013558101869;7059.152901651834;7063.470239731938;7066.399356054793;5020.774065167003;5038.773255203451;5106.974465127651;5260.947390526046;5331.760070796746;8208.220219079178;8399.328053755808;8442.451240669337;8475.830483390175;8530.488170709777;8395.160483951557;8586.356023298153;8589.65641374338;8693.956530217309;8726.781830454036;5963.850903727442;5997.580169388101;6359.96820015897;6480.513961453004;6483.967580162069;7046.964765176142;7217.097862767154;7311.524750891175;7316.012338334257;7350;6234.625922444487;6399.456046236122;6449.064885591469;6450.838729031811;6641.634710090992;6440.742370305323;6452.870942581216;6479.902801458076;6502.219733631994;6510.3489651034515;5911.733971971185;6003.90994135097;6008.969955150196;6015.518758499397;6016.067509536029;4187.895302617459;4189.07840275139;4243;4264.168487144977;4357.063231405263;4283.593058659422;4333.9349909750745;4343.022819865505;4402.779861007001;4473.485549161758 09:56:24 INFO - PROCESS | 20025 | |4;prototype.html;282.2745543952043;283.724786956652;289.331643902585;298.2737035318997;302.09070697201446;4512.61642760365;4658.394408726869;4730.479647238805;4743.501932297107;4756.4054493188305;4530.1166272576775;4584.724916505003;4650.255959046544;4664.530672838062;4692.178868697982;3746.30693321735;3753.3244016077097;3765.548134223897;3765.755225910321;3807.638274363931;3514.630963748808;3783.81080945953;3789.962100379002;3791.128040550675;3800.353939830222;3446.931061378771;3587.8923632290944;3720.702343812502;3720.8511659533588;3722.32998060349;3745.756525825813;3748.100455890594;3748.175401411685;3751.0869456577207;3754.662080412776;3327.1183136468853;3327.8169700666454;3330.167458135466;3336.7497437692027;3338.2322065924973;4570.794314255866;4611.930821037688;4641.118187544355;4679.3916790816975;4702.764861756898;4229.196452673982;4260.297050986584;4261.509926358477;4271.31658934569;4294.613484786384;4955.92018181367;4958.206686930074;4963.875903102416;5024.19612861944;5026.8240611578785;3491.5635545556806;3618.3848745713294;3619.8914032579064;3626.764260323097;3647.434647629622;5098.260752190911;5128.358955130609;5149.30484384607;5173.379194496647;5189.040027594907;3692.593814680383;3706.925861482809;3709.27669104522;3710.591834898159;3725.3294407006456;3769.5476542815036;3772.4152756322815;3789.6399842014966;3794.1273507093524;3797.8480860765812;3951.407288906687;4188.895277618084;4191.622753952098;4288.656907447396;4302.139572085595;4915.336429582032;4920.803167873245;4943.2585112233455;4970.329005584272;4999.700017998932;1260.1997731440601;1270.5807083662553;1275.489804078376;1279.6864768131868;1280.6350190195749;805.3758337288531;832.238501770885;896.5696465696371;909.2634965677822;930.6649606141918;4348.652107831366;4369.710935274102;4375.518692943773;4384.298512238091;4397.120575884772;5076.771545280471;5081.415637201695;5099.195442506681;5100.770465329069;5109.412417571953;4219.430376899079;4399.38408622793;4403.9779801100785;4414.183376075436;4423.911521769546;2688.8252263602803;2712.742289482496;2717.3750037491486;2723.428080103161;2724.4959682458807;4804.111239420718;4804.6876952997945;4810.494898035656;4810.807567697323;4812.342619609052;5025.6482046256415;5231.398389185292;5233.058049551041;5255.63210575256;5268.708111971305;4797.425917691342;4799.424069111659;4799.616030717534;4799.6400269979895;4819.662623616383;5093.796248150033;5119.616028797781;5132.6150538709;5148.4851514849715;5152.330197074356;4812.326274321527;5057.31726216956;5060.240963855304;5072.467390924047;5103.362079740033;4861.444337812008;4882.1212181806195;4928.827491037797;4944.678595891256;4945.653804233669;3638.9636103638622;3654.908627284339;3664.706823454064;3668.9816550917076;3670.1742108025483;5026.396832380138;5097.796088156432;5121.436641969306;5133.666311689728;5256.737163141751;4969.552740253394;4982.701037937735;4991.850244492671;4999.350084488993;5036.169032109661;4983.377077865267;4987.301777751045;4999.700017998932;5049.560875150564;5060.595152387727;4770.737609431515;4893.853184404474;4951.8266860659705;4974.701517908937;4975.402951645826;4745.928811067905;4861.4963293904375;4918.581920536794;4968.950310496994;5003.874903127451;4885.438174609823;4899.652595536256;4930;4952.2819191217795;4959.652824302264 09:56:24 INFO - PROCESS | 20025 | |5;yui.html;605.7334772700011;605.8394525450753;634.1185751804989;663.5355251324071;665.268204974528;12736.235825850456;12913.548025819098;12948.805767913465;13801.861981380183;13824.930875345623;12707.237565746062;12939.611811645642;12948.805767913489;12960.092793504458;12987.480500779957;594.8423667728056;738.2838646512887;757.2389748302948;760.4068826315455;760.9923900760976;612.6416046612737;726.0597526203553;737.8155461134717;747.4058123791599;751.9285667861544;788.2157253532743;790.115071120346;790.5138339920936;790.5533373643901;790.6007466229546;784.9843003139962;785.3403141361256;785.603270348476;785.8781888807245;786.4023342259924;466.16323698960446;466.5824087441721;473.5051870794993;473.9549742774431;474.94300683917805;11815.172937894351;12179.817302740466;12292.631221063382;12498.375081245902;12560.183588066746;12318.260904345769;13201.669958251025;13281.335933203301;13755.38100785467;14096;10405.271630985833;10405.479726013744;10453;10492.213084018653;10579.94710026445;3263.1189578813587;3267.7059064684054;3273.5908011498564;3278.065751260879;3300.6576498324853;61950.69024654893;62039;62174.0673889892;62518.37481625171;62945.685271573806;10063;10084.848727269096;10332.225083118647;10445.11216546587;10525.368477891197;19907.900460497603;19979.60040799205;20036.89981550083;20125.698114528295;20198.39404817858;6349.873002539924;6403.903941440882;6464;6605.471562275006;6737.898931516032;3250.317433338978;3263.4452143135723;3289.342131573695;3341.2983273512837;3394.253264281854;2757.531219692657;2844.687084420712;2859.4138201668607;2862.055521677841;2870.956935645967;456.74650568933896;464.5609898645747;465.6554149929028;465.75315083006063;467.0262502681878;478.0820824017894;484.6026258468093;506.5694159964075;524.3995625009419;546.3307448375708;7590.582517961455;7647.4477848651395;7882.566458844819;7924.960375198087;8448.619812108469;514.2723046888685;525.7949399734107;532.3186321508398;534.3134072716618;537.1647088776912;3981.203759248162;4114.650254728382;4138.482689663792;4269.103488267437;4284.935725964051;92150.53924730333;98852;101694.49152754189;102140;102925;83749;84609.57695211485;85103.5744821272;85721.57139214264;87309.5634521836;74923.62538187383;78241.99999999886;78963;79053.60473197597;79819.60090199744;7532.736354227576;7809.492382995087;7875.527468351917;8020.0375954885785;8144.959275203586;44494.3325850119;45839.31241031454;47346.76326618345;47965;48761.41720867637;64925;67436;67538.66230668816;67956.32043679697;69060.6546967262;9917.900820991987;10080.24398170155;10112.646057387956;10275.972402759964;10377;10746.83879741789;10811.729706757395;10892.292001019909;10913.56345746193;11289.71775705614;9719.757006074904;10145.543450544596;10779.245452818228;10785.298955567863;10796.406197659204;9863;9899.356541824758;9998.500074996076;10178.796424071625;10733.14134869193;9854.507274636097;9903;10057.083445800636;10366.274360794672;10420.635277765241;8351.791205219919;8424.578771061544;8630.439021463584;8659.913400865911;8765.868511972198;8548.658053678031;8901.51041692713;9219.677311294072;9297.488638124969;9448.338616296793 09:56:24 INFO - PROCESS | 20025 | __end_tp_report 09:56:24 INFO - PROCESS | 20025 | __start_cc_report 09:56:24 INFO - PROCESS | 20025 | _x_x_mozilla_cycle_collect,2363 09:56:24 INFO - PROCESS | 20025 | __end_cc_report 09:56:24 INFO - PROCESS | 20025 | __startTimestamp1476204984282__endTimestamp 09:56:24 INFO - PROCESS | 20025 | 09:56:24 INFO - PROCESS | 20025 | ------- Summary: start ------- 09:56:24 INFO - PROCESS | 20025 | Number of tests: 6 09:56:24 INFO - PROCESS | 20025 | 09:56:24 INFO - PROCESS | 20025 | [#0] dojo.html Cycles:165 Average:4515.23 Median:4622.56 stddev:467.79 (10.1%) stddev-sans-first:442.10 09:56:24 INFO - PROCESS | 20025 | Values: 2513.9 2540.8 2577.2 2579.2 2587.3 4486.6 4561.1 4570.0 4595.5 4598.8 4578.0 4593.9 4597.3 4600.7 4603.5 4160.0 4220.9 4234.4 4263.4 4290.6 4253.7 4283.9 4286.8 4288.1 4291.5 4184.1 4192.9 4213.3 4228.6 4294.6 4276.4 4278.4 4279.4 4303.2 4303.2 4086.4 4159.5 4173.9 4204.3 4256.3 4518.0 4519.4 4564.9 4576.9 4599.4 4870.1 4883.5 4884.2 4894.4 4968.6 4792.4 4844.6 4845.9 4899.2 4925.0 4572.6 4627.2 4635.2 4668.3 4685.8 5049.1 5049.3 5050.9 5051.9 5103.0 4838.6 4841.5 4842.6 4843.1 4893.7 4721.1 4776.6 4780.2 4847.4 4983.4 4851.4 4867.4 4920.7 4924.0 4930.9 4840.0 4844.2 4845.5 4850.1 4908.1 3991.3 3993.9 4096.8 4131.5 4198.7 3538.8 3583.8 3624.2 3625.3 3660.5 4245.2 4263.5 4270.9 4271.6 4321.6 4925.7 4927.8 4928.7 4935.7 4985.5 4170.5 4172.3 4213.2 4214.7 4228.4 4368.1 4421.7 4437.0 4440.9 4447.0 4587.2 4594.7 4596.9 4599.5 4657.3 4758.9 4866.8 4868.4 4868.6 4927.7 4508.7 4555.3 4569.9 4601.2 4602.1 4817.5 4822.6 4825.0 4873.7 4879.5 4875.7 4879.3 4884.9 4888.8 4890.3 4581.6 4622.6 4628.5 4678.6 4746.1 4654.2 4665.0 4676.0 4676.9 4679.3 4609.4 4629.6 4632.3 4633.9 4640.1 4677.8 4679.9 4680.7 4681.1 4684.9 4658.1 4699.7 4710.2 4762.5 4766.7 09:56:24 INFO - PROCESS | 20025 | 09:56:24 INFO - PROCESS | 20025 | [#1] ext.html Cycles:180 Average:41595.19 Median:33815.75 stddev:72023.19 (213.0%) stddev-sans-first:72159.35 09:56:24 INFO - PROCESS | 20025 | Values: 563.5 572.4 576.9 583.7 583.7 29511.4 30287.7 38323.6 38739.8 38935.2 39530.8 39896.8 39930.0 39936.0 39966.4 7563.6 7711.0 7714.0 7714.1 7719.5 7587.0 7691.3 7696.0 7716.3 7750.4 7750.7 7790.3 7793.1 7793.1 7794.5 7738.8 7757.7 7775.3 7783.7 7786.9 7577.3 7638.3 7652.3 7653.8 7657.6 36741.0 37004.8 37065.6 37082.0 37096.6 2943.7 3010.7 3044.6 3067.4 3276.9 27861.9 28074.3 28230.7 28494.9 29376.3 3165.3 3226.4 3243.3 3260.0 3296.4 247302.0 247794.0 247893.0 248542.0 248869.0 31590.7 46380.5 46628.8 46739.0 46743.0 30614.1 32421.4 32476.0 32519.2 32519.8 12127.8 12141.9 12151.8 12157.1 12158.6 11363.7 11438.5 11441.1 11442.3 11449.4 7744.5 7754.4 7780.1 7846.1 7860.0 3091.4 3112.3 3114.8 3140.5 3165.8 827.7 828.7 855.5 867.1 931.5 24186.2 25899.5 26190.9 26386.6 26526.9 872.5 915.5 935.5 951.3 975.4 13255.3 13685.3 13820.3 13994.7 14454.9 292149.0 294030.0 294382.0 294636.0 295086.0 45739.8 46320.8 46322.8 46335.3 46364.0 1059.4 1081.2 1106.6 1119.9 1179.0 26128.2 28694.3 28855.3 29496.4 29541.4 40701.0 41145.4 41160.0 41185.4 41220.6 278432.0 279822.0 280577.0 281663.0 281941.0 22208.6 22796.8 24401.4 25473.6 25519.7 39556.0 39843.0 40037.6 40212.4 40273.8 33843.8 34214.0 34248.3 34296.3 34762.0 33621.5 33649.0 34326.7 34386.3 34843.9 33787.7 33924.3 34175.7 34338.7 35049.0 26131.0 28475.4 29945.6 30745.4 30928.2 24051.4 24071.5 24302.1 24517.6 24519.3 09:56:24 INFO - PROCESS | 20025 | 09:56:24 INFO - PROCESS | 20025 | [#2] jquery.html Cycles:180 Average:23535.97 Median:28869.42 stddev:63568.78 (220.2%) stddev-sans-first:63723.26 09:56:24 INFO - PROCESS | 20025 | Values: 344.1 347.0 352.6 366.6 380.9 15467.8 16507.1 16601.4 16735.7 16736.2 15400.6 16055.1 16646.8 16743.6 16889.6 4975.7 5190.1 5219.4 5220.6 5221.1 3537.7 3684.2 5050.7 5149.6 5150.5 3854.0 3884.9 5937.4 6026.1 6034.1 5187.5 6002.3 6014.6 6018.0 6022.1 5345.3 5399.1 5405.1 5409.3 5414.0 12499.9 12605.9 12660.0 12745.3 12765.6 1810.0 1845.5 1850.0 1963.3 2071.5 8749.7 9158.6 9416.2 9716.3 9832.5 1695.2 1729.4 1748.5 1778.5 1823.2 64105.7 64157.0 64264.7 64609.7 64648.4 8975.1 9050.9 9219.0 9286.7 9484.9 11991.9 12055.0 12056.5 12062.4 12125.2 6882.9 6910.0 6914.3 7146.4 7171.1 6707.0 6844.1 6976.1 7013.6 7065.4 3917.2 4023.8 4316.3 4369.5 4376.8 1628.8 1673.5 1683.9 1701.5 1725.7 764.3 773.7 796.9 805.3 843.8 15487.1 15968.7 16476.6 16726.2 16832.7 798.0 804.0 822.3 831.5 883.0 8606.8 8825.7 9132.5 9279.6 9436.2 379814.0 382565.0 385048.0 389169.0 390111.0 68949.7 70220.6 70877.6 71548.0 72933.3 880.7 930.8 940.4 940.4 941.7 15710.3 15823.3 16276.8 16616.0 16646.5 39394.2 39481.8 39577.6 39788.0 41057.2 52185.0 52517.7 53862.7 54452.7 54770.5 7014.6 7573.2 7577.3 7679.7 7852.3 8628.2 10802.2 10914.3 10918.5 11229.2 8842.3 9180.2 9269.1 9471.2 9690.9 4746.3 9747.1 9771.6 10257.2 10274.8 9647.7 10003.2 10073.5 10099.8 10224.2 7302.2 7349.6 7454.3 7499.4 7615.2 8511.2 9494.6 9611.0 9626.4 10061.0 09:56:24 INFO - PROCESS | 20025 | 09:56:24 INFO - PROCESS | 20025 | [#3] mootools.html Cycles:180 Average:4826.60 Median:5621.75 stddev:2676.59 (47.6%) stddev-sans-first:2670.09 09:56:24 INFO - PROCESS | 20025 | Values: 1182.6 1311.9 1361.7 1409.3 1665.1 6455.6 6873.4 7191.7 7462.6 7473.6 7419.4 7452.2 7473.3 7482.5 7484.3 2064.7 2089.8 2090.2 2092.6 2092.9 2030.4 2059.6 2061.3 2082.2 2082.5 2079.0 2080.4 2082.0 2083.7 2088.4 2044.5 2047.1 2048.1 2051.5 2054.1 1994.5 2003.9 2007.9 2019.4 2049.1 7431.8 7529.7 7530.1 7532.9 7534.7 4250.8 4368.2 4379.3 4432.6 4442.3 2741.3 2852.5 2910.5 2913.4 2914.2 872.2 884.6 904.3 917.2 925.5 9742.4 9947.5 9967.5 9969.9 10015.3 3571.7 3770.0 3802.1 3864.7 3883.7 7902.5 7917.6 7920.8 7923.7 7926.4 4306.8 4329.4 4329.6 4330.6 4335.2 3568.6 3672.8 3998.9 4061.3 4066.1 3217.2 3305.8 3376.8 3389.7 3393.8 1015.0 1019.7 1028.7 1033.7 1045.5 636.3 731.9 758.5 766.6 784.9 4840.9 4905.4 5092.9 5120.1 5220.4 797.0 848.3 853.5 855.4 859.5 3247.9 3294.2 3371.5 3420.4 3518.6 8273.0 8826.6 8869.2 8874.2 8876.9 8526.7 8797.2 8808.9 8814.6 8816.3 6815.9 7046.0 7059.2 7063.5 7066.4 5020.8 5038.8 5107.0 5260.9 5331.8 8208.2 8399.3 8442.5 8475.8 8530.5 8395.2 8586.4 8589.7 8694.0 8726.8 5963.9 5997.6 6360.0 6480.5 6484.0 7047.0 7217.1 7311.5 7316.0 7350.0 6234.6 6399.5 6449.1 6450.8 6641.6 6440.7 6452.9 6479.9 6502.2 6510.3 5911.7 6003.9 6009.0 6015.5 6016.1 4187.9 4189.1 4243.0 4264.2 4357.1 4283.6 4333.9 4343.0 4402.8 4473.5 09:56:24 INFO - PROCESS | 20025 | 09:56:24 INFO - PROCESS | 20025 | [#4] prototype.html Cycles:180 Average:4144.58 Median:4697.47 stddev:1192.00 (25.4%) stddev-sans-first:1159.56 09:56:24 INFO - PROCESS | 20025 | Values: 282.3 283.7 289.3 298.3 302.1 4512.6 4658.4 4730.5 4743.5 4756.4 4530.1 4584.7 4650.3 4664.5 4692.2 3746.3 3753.3 3765.5 3765.8 3807.6 3514.6 3783.8 3790.0 3791.1 3800.4 3446.9 3587.9 3720.7 3720.9 3722.3 3745.8 3748.1 3748.2 3751.1 3754.7 3327.1 3327.8 3330.2 3336.7 3338.2 4570.8 4611.9 4641.1 4679.4 4702.8 4229.2 4260.3 4261.5 4271.3 4294.6 4955.9 4958.2 4963.9 5024.2 5026.8 3491.6 3618.4 3619.9 3626.8 3647.4 5098.3 5128.4 5149.3 5173.4 5189.0 3692.6 3706.9 3709.3 3710.6 3725.3 3769.5 3772.4 3789.6 3794.1 3797.8 3951.4 4188.9 4191.6 4288.7 4302.1 4915.3 4920.8 4943.3 4970.3 4999.7 1260.2 1270.6 1275.5 1279.7 1280.6 805.4 832.2 896.6 909.3 930.7 4348.7 4369.7 4375.5 4384.3 4397.1 5076.8 5081.4 5099.2 5100.8 5109.4 4219.4 4399.4 4404.0 4414.2 4423.9 2688.8 2712.7 2717.4 2723.4 2724.5 4804.1 4804.7 4810.5 4810.8 4812.3 5025.6 5231.4 5233.1 5255.6 5268.7 4797.4 4799.4 4799.6 4799.6 4819.7 5093.8 5119.6 5132.6 5148.5 5152.3 4812.3 5057.3 5060.2 5072.5 5103.4 4861.4 4882.1 4928.8 4944.7 4945.7 3639.0 3654.9 3664.7 3669.0 3670.2 5026.4 5097.8 5121.4 5133.7 5256.7 4969.6 4982.7 4991.9 4999.4 5036.2 4983.4 4987.3 4999.7 5049.6 5060.6 4770.7 4893.9 4951.8 4974.7 4975.4 4745.9 4861.5 4918.6 4969.0 5003.9 4885.4 4899.7 4930.0 4952.3 4959.7 09:56:24 INFO - PROCESS | 20025 | 09:56:24 INFO - PROCESS | 20025 | [#5] yui.html Cycles:180 Average:17864.55 Median:24224.80 stddev:26245.09 (108.3%) stddev-sans-first:26286.72 09:56:24 INFO - PROCESS | 20025 | Values: 605.7 605.8 634.1 663.5 665.3 12736.2 12913.5 12948.8 13801.9 13824.9 12707.2 12939.6 12948.8 12960.1 12987.5 594.8 738.3 757.2 760.4 761.0 612.6 726.1 737.8 747.4 751.9 788.2 790.1 790.5 790.6 790.6 785.0 785.3 785.6 785.9 786.4 466.2 466.6 473.5 474.0 474.9 11815.2 12179.8 12292.6 12498.4 12560.2 12318.3 13201.7 13281.3 13755.4 14096.0 10405.3 10405.5 10453.0 10492.2 10579.9 3263.1 3267.7 3273.6 3278.1 3300.7 61950.7 62039.0 62174.1 62518.4 62945.7 10063.0 10084.8 10332.2 10445.1 10525.4 19907.9 19979.6 20036.9 20125.7 20198.4 6349.9 6403.9 6464.0 6605.5 6737.9 3250.3 3263.4 3289.3 3341.3 3394.3 2757.5 2844.7 2859.4 2862.1 2871.0 456.7 464.6 465.7 465.8 467.0 478.1 484.6 506.6 524.4 546.3 7590.6 7647.4 7882.6 7925.0 8448.6 514.3 525.8 532.3 534.3 537.2 3981.2 4114.7 4138.5 4269.1 4284.9 92150.5 98852.0 101694.5 102140.0 102925.0 83749.0 84609.6 85103.6 85721.6 87309.6 74923.6 78242.0 78963.0 79053.6 79819.6 7532.7 7809.5 7875.5 8020.0 8145.0 44494.3 45839.3 47346.8 47965.0 48761.4 64925.0 67436.0 67538.7 67956.3 69060.7 9917.9 10080.2 10112.6 10276.0 10377.0 10746.8 10811.7 10892.3 10913.6 11289.7 9719.8 10145.5 10779.2 10785.3 10796.4 9863.0 9899.4 9998.5 10178.8 10733.1 9854.5 9903.0 10057.1 10366.3 10420.6 8351.8 8424.6 8630.4 8659.9 8765.9 8548.7 8901.5 9219.7 9297.5 9448.3 09:56:24 INFO - PROCESS | 20025 | -------- Summary: end -------- 09:56:24 INFO - PROCESS | 20025 | 09:56:25 INFO - TEST-INFO | 20025: exit 0 09:56:25 INFO - TEST-OK | dromaeo_css | took 1122081ms 09:56:25 INFO - TEST-START | kraken 09:56:25 INFO - operating with platform_type : linux_ 09:56:25 INFO - Initialising browser for kraken test... 09:56:25 INFO - TEST-INFO | started process 20334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE1r2zd/profile http://localhost:51634/getInfo.html) 09:56:29 INFO - PROCESS | 20334 | __metrics Screen width/height:1600/1200 09:56:29 INFO - PROCESS | 20334 | colorDepth:24 09:56:29 INFO - PROCESS | 20334 | Browser inner width/height: 1024/697 09:56:29 INFO - PROCESS | 20334 | __metrics 09:56:29 INFO - PROCESS | 20334 | 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" 09:56:29 INFO - PROCESS | 20334 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:56:30 INFO - PROCESS | 20334 | console.error: PushService: 09:56:30 INFO - PROCESS | 20334 | stateChangeProcessEnqueue: Error transitioning state 09:56:30 INFO - PROCESS | 20334 | UnknownError 09:56:31 INFO - TEST-INFO | 20334: exit 0 09:56:31 INFO - Browser initialized. 09:56:31 INFO - Running cycle 1/1 for kraken test... 09:56:31 INFO - TEST-INFO | started process 20418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE1r2zd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:56:43 INFO - PROCESS | 20418 | RSS: Main: 174092288 09:56:43 INFO - PROCESS | 20418 | 09:56:46 INFO - PROCESS | 20418 | Cycle 1(1): loaded http://localhost:51634/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51634/tests/kraken/driver.html?testName=audio-beat-detection) 09:56:47 INFO - PROCESS | 20418 | RSS: Main: 232566784 09:56:47 INFO - PROCESS | 20418 | 09:56:49 INFO - PROCESS | 20418 | Cycle 1(1): loaded http://localhost:51634/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51634/tests/kraken/driver.html?testName=audio-dft) 09:56:50 INFO - PROCESS | 20418 | RSS: Main: 217747456 09:56:50 INFO - PROCESS | 20418 | 09:56:53 INFO - PROCESS | 20418 | Cycle 1(1): loaded http://localhost:51634/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51634/tests/kraken/driver.html?testName=audio-fft) 09:56:54 INFO - PROCESS | 20418 | RSS: Main: 299782144 09:56:54 INFO - PROCESS | 20418 | 09:56:56 INFO - PROCESS | 20418 | Cycle 1(1): loaded http://localhost:51634/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51634/tests/kraken/driver.html?testName=audio-oscillator) 09:56:57 INFO - PROCESS | 20418 | RSS: Main: 210341888 09:56:57 INFO - PROCESS | 20418 | 09:56:59 INFO - PROCESS | 20418 | Cycle 1(1): loaded http://localhost:51634/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51634/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:57:00 INFO - PROCESS | 20418 | RSS: Main: 213311488 09:57:00 INFO - PROCESS | 20418 | 09:57:03 INFO - PROCESS | 20418 | Cycle 1(1): loaded http://localhost:51634/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51634/tests/kraken/driver.html?testName=imaging-darkroom) 09:57:03 INFO - PROCESS | 20418 | RSS: Main: 249753600 09:57:03 INFO - PROCESS | 20418 | 09:57:07 INFO - PROCESS | 20418 | Cycle 1(1): loaded http://localhost:51634/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51634/tests/kraken/driver.html?testName=imaging-desaturate) 09:57:07 INFO - PROCESS | 20418 | RSS: Main: 248872960 09:57:07 INFO - PROCESS | 20418 | 09:57:10 INFO - PROCESS | 20418 | Cycle 1(1): loaded http://localhost:51634/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51634/tests/kraken/driver.html?testName=json-parse-financial) 09:57:11 INFO - PROCESS | 20418 | RSS: Main: 248156160 09:57:11 INFO - PROCESS | 20418 | 09:57:13 INFO - PROCESS | 20418 | Cycle 1(1): loaded http://localhost:51634/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51634/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:57:13 INFO - PROCESS | 20418 | RSS: Main: 211013632 09:57:13 INFO - PROCESS | 20418 | 09:57:15 INFO - PROCESS | 20418 | Cycle 1(1): loaded http://localhost:51634/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51634/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:57:16 INFO - PROCESS | 20418 | RSS: Main: 218402816 09:57:16 INFO - PROCESS | 20418 | 09:57:18 INFO - PROCESS | 20418 | Cycle 1(1): loaded http://localhost:51634/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51634/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:57:19 INFO - PROCESS | 20418 | RSS: Main: 227487744 09:57:19 INFO - PROCESS | 20418 | 09:57:21 INFO - PROCESS | 20418 | Cycle 1(1): loaded http://localhost:51634/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51634/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:57:22 INFO - PROCESS | 20418 | RSS: Main: 235700224 09:57:22 INFO - PROCESS | 20418 | 09:57:25 INFO - PROCESS | 20418 | Cycle 1(1): loaded http://localhost:51634/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51634/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:57:26 INFO - PROCESS | 20418 | RSS: Main: 233021440 09:57:26 INFO - PROCESS | 20418 | 09:57:28 INFO - PROCESS | 20418 | Cycle 1(1): loaded http://localhost:51634/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51634/tests/kraken/driver.html?testName=ai-astar) 09:57:28 INFO - PROCESS | 20418 | RSS: Main: 283230208 09:57:28 INFO - PROCESS | 20418 | 09:57:28 INFO - PROCESS | 20418 | __start_tp_report 09:57:28 INFO - PROCESS | 20418 | _x_x_mozilla_page_load 09:57:28 INFO - PROCESS | 20418 | _x_x_mozilla_page_load_details 09:57:28 INFO - PROCESS | 20418 | |i|pagename|runs| 09:57:28 INFO - PROCESS | 20418 | |0;ai-astar;111;117;114;115;113;114;113;117;114;114 09:57:28 INFO - PROCESS | 20418 | |1;audio-beat-detection;154;129;125;173;141;127;134;132;175;132 09:57:28 INFO - PROCESS | 20418 | |2;audio-dft;161;160;163;162;162;160;160;162;161;161 09:57:28 INFO - PROCESS | 20418 | |3;audio-fft;76;76;78;113;77;77;77;77;99;76 09:57:28 INFO - PROCESS | 20418 | |4;audio-oscillator;84;84;122;83;84;84;109;83;83;119 09:57:28 INFO - PROCESS | 20418 | |5;imaging-gaussian-blur;117;117;117;117;117;116;118;117;117;117 09:57:28 INFO - PROCESS | 20418 | |6;imaging-darkroom;148;146;146;147;147;146;146;148;148;146 09:57:28 INFO - PROCESS | 20418 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;97;94 09:57:28 INFO - PROCESS | 20418 | |8;json-parse-financial;64;65;64;64;63;65;64;65;64;64 09:57:28 INFO - PROCESS | 20418 | |9;json-stringify-tinderbox;66;66;65;66;67;66;66;65;66;66 09:57:28 INFO - PROCESS | 20418 | |10;stanford-crypto-aes;84;84;91;83;83;82;82;83;83;82 09:57:28 INFO - PROCESS | 20418 | |11;stanford-crypto-ccm;142;147;142;139;138;144;139;147;194;148 09:57:28 INFO - PROCESS | 20418 | |12;stanford-crypto-pbkdf2;174;177;173;176;175;177;179;181;177;172 09:57:28 INFO - PROCESS | 20418 | |13;stanford-crypto-sha256-iterative;70;73;69;74;70;70;71;69;70;72 09:57:28 INFO - PROCESS | 20418 | __end_tp_report 09:57:28 INFO - PROCESS | 20418 | __start_cc_report 09:57:28 INFO - PROCESS | 20418 | _x_x_mozilla_cycle_collect,1938 09:57:28 INFO - PROCESS | 20418 | __end_cc_report 09:57:28 INFO - PROCESS | 20418 | __startTimestamp1476205048344__endTimestamp 09:57:28 INFO - PROCESS | 20418 | 09:57:28 INFO - PROCESS | 20418 | ------- Summary: start ------- 09:57:28 INFO - PROCESS | 20418 | Number of tests: 14 09:57:28 INFO - PROCESS | 20418 | 09:57:28 INFO - PROCESS | 20418 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:1.81 (1.6%) stddev-sans-first:1.51 09:57:28 INFO - PROCESS | 20418 | Values: 111.0 117.0 114.0 115.0 113.0 114.0 113.0 117.0 114.0 114.0 09:57:28 INFO - PROCESS | 20418 | 09:57:28 INFO - PROCESS | 20418 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:137.50 stddev:18.68 (13.6%) stddev-sans-first:19.32 09:57:28 INFO - PROCESS | 20418 | Values: 154.0 129.0 125.0 173.0 141.0 127.0 134.0 132.0 175.0 132.0 09:57:28 INFO - PROCESS | 20418 | 09:57:28 INFO - PROCESS | 20418 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:1.09 09:57:28 INFO - PROCESS | 20418 | Values: 161.0 160.0 163.0 162.0 162.0 160.0 160.0 162.0 161.0 161.0 09:57:28 INFO - PROCESS | 20418 | 09:57:28 INFO - PROCESS | 20418 | [#3] audio-fft Cycles:10 Average:82.60 Median:77.00 stddev:12.78 (16.6%) stddev-sans-first:13.33 09:57:28 INFO - PROCESS | 20418 | Values: 76.0 76.0 78.0 113.0 77.0 77.0 77.0 77.0 99.0 76.0 09:57:28 INFO - PROCESS | 20418 | 09:57:28 INFO - PROCESS | 20418 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:83.50 stddev:16.31 (19.5%) stddev-sans-first:16.93 09:57:28 INFO - PROCESS | 20418 | Values: 84.0 84.0 122.0 83.0 84.0 84.0 109.0 83.0 83.0 119.0 09:57:28 INFO - PROCESS | 20418 | 09:57:28 INFO - PROCESS | 20418 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 09:57:28 INFO - PROCESS | 20418 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 118.0 117.0 117.0 117.0 09:57:28 INFO - PROCESS | 20418 | 09:57:28 INFO - PROCESS | 20418 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 09:57:28 INFO - PROCESS | 20418 | Values: 148.0 146.0 146.0 147.0 147.0 146.0 146.0 148.0 148.0 146.0 09:57:28 INFO - PROCESS | 20418 | 09:57:28 INFO - PROCESS | 20418 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 09:57:28 INFO - PROCESS | 20418 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 97.0 94.0 09:57:28 INFO - PROCESS | 20418 | 09:57:28 INFO - PROCESS | 20418 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 09:57:28 INFO - PROCESS | 20418 | Values: 64.0 65.0 64.0 64.0 63.0 65.0 64.0 65.0 64.0 64.0 09:57:28 INFO - PROCESS | 20418 | 09:57:28 INFO - PROCESS | 20418 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 09:57:28 INFO - PROCESS | 20418 | Values: 66.0 66.0 65.0 66.0 67.0 66.0 66.0 65.0 66.0 66.0 09:57:28 INFO - PROCESS | 20418 | 09:57:28 INFO - PROCESS | 20418 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:2.67 (3.2%) stddev-sans-first:2.83 09:57:28 INFO - PROCESS | 20418 | Values: 84.0 84.0 91.0 83.0 83.0 82.0 82.0 83.0 83.0 82.0 09:57:28 INFO - PROCESS | 20418 | 09:57:28 INFO - PROCESS | 20418 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:145.50 stddev:16.56 (11.4%) stddev-sans-first:17.42 09:57:28 INFO - PROCESS | 20418 | Values: 142.0 147.0 142.0 139.0 138.0 144.0 139.0 147.0 194.0 148.0 09:57:28 INFO - PROCESS | 20418 | 09:57:28 INFO - PROCESS | 20418 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:177.00 stddev:2.73 (1.5%) stddev-sans-first:2.78 09:57:28 INFO - PROCESS | 20418 | Values: 174.0 177.0 173.0 176.0 175.0 177.0 179.0 181.0 177.0 172.0 09:57:28 INFO - PROCESS | 20418 | 09:57:28 INFO - PROCESS | 20418 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:70.50 stddev:1.69 (2.4%) stddev-sans-first:1.76 09:57:28 INFO - PROCESS | 20418 | Values: 70.0 73.0 69.0 74.0 70.0 70.0 71.0 69.0 70.0 72.0 09:57:28 INFO - PROCESS | 20418 | -------- Summary: end -------- 09:57:28 INFO - PROCESS | 20418 | 09:57:29 INFO - TEST-INFO | 20418: exit 0 09:57:29 INFO - TEST-OK | kraken | took 64416ms 09:57:29 INFO - SUITE-END | took 1186s 09:57:29 INFO - Completed test suite (00:19:46) 09:57:29 INFO - javascript benchmark 09:57:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2513.8743062846856, 2540.8221424500293, 2577.1881857214976, 2579.187555919885, 2587.3402282417983, 4486.6410687145035, 4561.064981678756, 4569.977150114249, 4595.517470665583, 4598.81604735811, 4578.015726618784, 4593.908121837561, 4597.310403439477, 4600.723956562609, 4603.4706008809, 4160.043190066287, 4220.915581688364, 4234.407182994383, 4263.445752052229, 4290.6138447539715, 4253.744775313491, 4283.914321713564, 4286.807093680792, 4288.120935208275, 4291.506476755167, 4184.121334519755, 4192.937105943413, 4213.325867861143, 4228.5982831630945, 4294.570542945696, 4276.358546218061, 4278.379634952915, 4279.443672322609, 4303.225419424502, 4303.225419424518, 4086.366613174963, 4159.542450330491, 4173.937390939138, 4204.26425375558, 4256.297710877701, 4517.954820451819, 4519.41247637805, 4564.908701825978, 4576.8626941191815, 4599.425071866017, 4870.05034018363, 4883.4628190898975, 4884.242942343943, 4894.36373271476, 4968.6025117990475, 4792.400949881265, 4844.5882100021545, 4845.854624361275, 4899.191633380524, 4925.0, 4572.588467037949, 4627.167109920179, 4635.188841952645, 4668.253079507263, 4685.765711714401, 5049.141645920203, 5049.293098966147, 5050.9494905051215, 5051.898962020739, 5102.974485127625, 4838.564529192389, 4841.491643377465, 4842.58837998767, 4843.128236917389, 4893.73084480357, 4721.102990431807, 4776.5701086902345, 4780.235162374003, 4847.442544107403, 4983.377077865267, 4851.369321988119, 4867.367242258554, 4920.6555541111775, 4923.950760492421, 4930.926036109461, 4840.0, 4844.15227335222, 4845.515448455127, 4850.054239423279, 4908.092002979389, 3991.2815693175507, 3993.8602148924647, 4096.754194748325, 4131.5248746394545, 4198.748075115442, 3538.7522873398616, 3583.8028908409765, 3624.1664417184197, 3625.274945011008, 3660.4692319613505, 4245.1934132514725, 4263.488381394252, 4270.850520231839, 4271.5514870938105, 4321.5678432157165, 4925.655204135748, 4927.827526036572, 4928.704277743347, 4935.679180853233, 4985.451600323961, 4170.457840480718, 4172.311568591149, 4213.157368526307, 4214.704970652025, 4228.429162063144, 4368.08270263242, 4421.712588681726, 4437.0460351024685, 4440.933385999213, 4447.043885564619, 4587.151376995266, 4594.678372514026, 4596.862094137181, 4599.5400459953735, 4657.278121891112, 4758.928616070692, 4866.780994855169, 4868.391451068616, 4868.561829435368, 4927.704337739747, 4508.729476231437, 4555.31670249452, 4569.931451028304, 4601.217792975135, 4602.125596136723, 4817.494163112963, 4822.590079843252, 4824.986752781955, 4873.6832105913, 4879.536444037811, 4875.731834749123, 4879.316895634543, 4884.877878053077, 4888.755562221946, 4890.266460031024, 4581.610563102174, 4622.560856718606, 4628.490866004669, 4678.625709943129, 4746.121967436035, 4654.185517534485, 4665.04366604852, 4675.976620116878, 4676.859694209179, 4679.344891715231, 4609.377734005866, 4629.629629629689, 4632.25883858581, 4633.86098417048, 4640.118377508263, 4677.76611169447, 4679.9064018718755, 4680.742559159279, 4681.110588988081, 4684.882877927943, 4658.114958157939, 4699.694519856198, 4710.152172608963, 4762.547557981986, 4766.737829419415], "value": 4485.579245424095, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.5041163775877, 572.3904042195062, 576.9394213607568, 583.699394811672, 583.7198144890452, 29511.409771804552, 30287.697123028764, 38323.61676383235, 38739.80630096853, 38935.22129557414, 39530.802345988304, 39896.800515997376, 39930.0, 39936.0, 39966.40050399247, 7563.621818909046, 7710.961445192766, 7713.961430192841, 7714.074311082678, 7719.536827790323, 7587.0, 7691.269329413697, 7696.037995250594, 7716.305532502074, 7750.379969602446, 7750.728724494644, 7790.337821285198, 7793.064832220141, 7793.103793063785, 7794.493357931745, 7738.7678369649, 7757.728479503218, 7775.339096176832, 7783.727569535095, 7786.922130778677, 7577.280158384945, 7638.274363935418, 7652.311291983692, 7653.770386888402, 7657.578833164173, 36741.0, 37004.81497592522, 37065.62934370649, 37082.0, 37096.629033709585, 2943.735063844243, 3010.653774815902, 3044.634643842731, 3067.432524982863, 3276.918077048069, 27861.86069069662, 28074.298142546395, 28230.71769282322, 28494.857525712447, 29376.265593360124, 3165.2878102427, 3226.4353738095974, 3243.254051568129, 3260.005698262029, 3296.3736889991064, 247302.0, 247794.0, 247893.0, 248542.0, 248868.9999999982, 31590.684093159234, 46380.5361946383, 46628.7668561655, 46739.0, 46743.0, 30614.081577552708, 32421.351572968408, 32476.0, 32519.18702032468, 32519.837400812845, 12127.818082728767, 12141.878581214252, 12151.756964860653, 12157.148999569945, 12158.574449894388, 11363.659090227306, 11438.485268162785, 11441.084713222923, 11442.256253343507, 11449.370284634258, 7744.457887947902, 7754.379649628129, 7780.14418413974, 7846.097698764601, 7859.960700196462, 3091.350816328596, 3112.2841746398453, 3114.7508199343997, 3140.450421176285, 3165.8258795766455, 827.7020272701823, 828.718235799831, 855.461059532503, 867.098217853438, 931.5481991234246, 24186.153484627954, 25899.482010359687, 26190.869045655032, 26386.604200937003, 26526.867365663435, 872.4721543466238, 915.5285028210477, 935.5041827831125, 951.2722767083187, 975.4391225045628, 13255.337233138305, 13685.31573421345, 13820.308984550733, 13994.720105597831, 14454.855451445352, 292149.0, 294030.0, 294382.0, 294636.0, 295086.0, 45739.77130114328, 46320.7683961578, 46322.768386158525, 46335.30497042547, 46364.0, 1059.4490864750442, 1081.1837063017372, 1106.618216715232, 1119.8936101070385, 1178.9957072975976, 26128.216153515426, 28694.282642934093, 28855.278618033877, 29496.410071798015, 29541.409171816875, 40701.0, 41145.38281925833, 41160.0, 41185.38221926733, 41220.587794121675, 278432.0, 279822.0, 280577.0, 281663.0, 281941.0, 22208.555828883655, 22796.772032279467, 24401.38996525101, 25473.598952057815, 25519.744802551737, 39556.0, 39843.0, 40037.59962400455, 40212.3968140484, 40273.798631006655, 33843.830780845936, 34214.0, 34248.315033699684, 34296.31407371889, 34762.0, 33621.49567756535, 33649.0, 34326.656733433345, 34386.312273754884, 34843.90936543816, 33787.66212337845, 33924.32151357008, 34175.658243417245, 34338.656613433544, 35049.0, 26131.0, 28475.43049139047, 29945.550816738203, 30745.38509229758, 30928.226794330323, 24051.398715032265, 24071.51856962886, 24302.149424770047, 24517.632235516838, 24519.26442206737], "value": 15672.657790099238, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.0881663591482, 346.9930601387972, 352.62445495547234, 366.5711117991949, 380.8609857402049, 15467.845321546782, 16507.09210993395, 16601.41895033674, 16735.748963765524, 16736.16319184042, 15400.61498462539, 16055.116968566754, 16646.75029874553, 16743.581410464743, 16889.577760555992, 4975.701457912528, 5190.091733946563, 5219.42586315505, 5220.556252718524, 5221.112410890158, 3537.6816086552203, 3684.171061511152, 5050.671706339076, 5149.613778966593, 5150.484951504838, 3853.9614603854025, 3884.9028774280587, 5937.406259374071, 6026.126211699301, 6034.064719968412, 5187.481251874782, 6002.339742628307, 6014.639121652671, 6018.007028840236, 6022.096685497167, 5345.33183352081, 5399.136138217906, 5405.081136206854, 5409.323834520685, 5414.0, 12499.93750031244, 12605.93697031518, 12660.0, 12745.299008554526, 12765.61703148907, 1809.9909500452545, 1845.5109396010068, 1849.9825096197171, 1963.2834015584351, 2071.482129467633, 8749.693760718408, 9158.633654653806, 9416.246700263962, 9716.271279654055, 9832.459214743187, 1695.211726547149, 1729.4206440842333, 1748.545378201664, 1778.4664600619762, 1823.2342416185234, 64105.67947160281, 64157.0, 64264.67867660678, 64609.67695161494, 64648.353516464704, 8975.057618950046, 9050.909490905007, 9218.953905230432, 9286.72139835806, 9484.90515094854, 11991.940040299743, 12054.975327097294, 12056.457459414347, 12062.396880155957, 12125.151239413333, 6882.931170688229, 6910.0, 6914.343137402039, 7146.428285737128, 7171.1394632644415, 6707.0, 6844.1444819397575, 6976.064370048449, 7013.649317534205, 7065.364117229474, 3917.238346965383, 4023.8189281482405, 4316.330968699856, 4369.453818272716, 4376.781160942004, 1628.8371162883855, 1673.5314112048645, 1683.9242234099495, 1701.5490894912857, 1725.6634956183423, 764.3312101910828, 773.7291947818219, 796.9083555391088, 805.3235282362843, 843.767963809945, 15487.148206848506, 15968.680626387639, 16476.588085297724, 16726.24731887068, 16832.74750878738, 797.9960100199462, 803.9718609848627, 822.272289024206, 831.4803247970019, 883.0242581946984, 8606.784830379165, 8825.735227943043, 9132.543372831331, 9279.62881484733, 9436.169149255196, 379814.0, 382565.0, 385048.0, 389169.0, 390111.0, 68949.65525172342, 70220.64889675518, 70877.64561177265, 71548.0, 72933.2706672937, 880.665347168072, 930.8184903943666, 940.4216406909838, 940.4263399326542, 941.6892425499568, 15710.293036813142, 15823.287952041956, 16276.837231628006, 16616.0, 16646.50060498187, 39394.2121157581, 39481.80259098686, 39577.604223957394, 39787.99999999884, 41057.1788564233, 52185.0, 52517.7374113127, 53862.730686346316, 54452.72773636265, 54770.45229547813, 7014.614196219257, 7573.242675732383, 7577.280158384945, 7679.654415551426, 7852.255958502948, 8628.22345988864, 10802.189835762507, 10914.345139291669, 10918.508667110158, 11229.21395502307, 8842.292616590787, 9180.17378435944, 9269.119433653792, 9471.19494842946, 9690.903090969001, 4746.264329029006, 9747.122758951728, 9771.560279787285, 10257.230707696803, 10274.845877311696, 9647.719562385757, 10003.199744020316, 10073.546690399096, 10099.79800403973, 10224.1820654346, 7302.19675835647, 7349.595772232578, 7454.254574542502, 7499.362554182955, 7615.238476152341, 8511.191436813493, 9494.572744226665, 9611.0, 9626.374285671409, 10061.0], "value": 7817.157100357364, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1182.550630760311, 1311.8622544632817, 1361.734461779953, 1409.337611322678, 1665.092524574107, 6455.612663240203, 6873.415759660428, 7191.748288809893, 7462.626868656573, 7473.6263186840715, 7419.443541734365, 7452.180260171391, 7473.290037446447, 7482.513636613617, 7484.288992545713, 2064.6593312103487, 2089.8014688604635, 2090.216168936649, 2092.571022940301, 2092.9058192381303, 2030.4416285521452, 2059.639563076463, 2061.3197644777188, 2082.1775398717496, 2082.458560774202, 2078.9792102079014, 2080.365488525999, 2082.0422605601366, 2083.72911521502, 2088.363049269972, 2044.4684382060698, 2047.1299697628597, 2048.109072553444, 2051.5281485258474, 2054.1064636883, 1994.481434826941, 2003.9298624548217, 2007.9397618071482, 2019.424464027745, 2049.067674208232, 7431.777046688554, 7529.661165247522, 7530.096388433423, 7532.887006694904, 7534.660940257701, 4250.787460626956, 4368.170047690928, 4379.343098535245, 4432.623227025707, 4442.267025940716, 2741.314671332167, 2852.472292625871, 2910.5052141136057, 2913.373624670706, 2914.2277296516227, 872.1714371347246, 884.6328773558965, 904.3307952115453, 917.2020342302174, 925.4632313258294, 9742.415455072718, 9947.502624868728, 9967.45179015154, 9969.90030099697, 10015.298929074896, 3571.6606922342335, 3769.965178031711, 3802.125511132455, 3864.748791328611, 3883.66988805949, 7902.4863383879865, 7917.564533950688, 7920.762377128695, 7923.7226697065325, 7926.365890728728, 4306.827726890952, 4329.372241025034, 4329.567043295709, 4330.631896288788, 4335.241332766753, 3568.5896121946307, 3672.779633222015, 3998.9000274992777, 4061.3095773718537, 4066.1461093170174, 3217.2439476722952, 3305.7851239669344, 3376.7973921564785, 3389.694927456541, 3393.8472768725464, 1015.007469109542, 1019.7399663086014, 1028.681108856257, 1033.7415646088477, 1045.4720366215013, 636.2714691678095, 731.8719224135755, 758.4728613613596, 766.5745511241315, 784.9058113026359, 4840.903181936342, 4905.411350637946, 5092.898142037138, 5120.129577971754, 5220.399654039758, 796.9960150199212, 848.3255811629646, 853.5390888920037, 855.4183155454226, 859.5315553023618, 3247.8700851966128, 3294.1599892027857, 3371.544841446422, 3420.401429749784, 3518.595361533405, 8272.958635206785, 8826.602802873886, 8869.201771840566, 8874.245689116367, 8876.911230887737, 8526.65893364271, 8797.164269394398, 8808.91191088081, 8814.559272036373, 8816.294696424271, 6815.931840681629, 7046.013558101869, 7059.152901651834, 7063.470239731938, 7066.399356054793, 5020.774065167003, 5038.773255203451, 5106.974465127651, 5260.947390526046, 5331.760070796746, 8208.220219079178, 8399.328053755808, 8442.451240669337, 8475.830483390175, 8530.488170709777, 8395.160483951557, 8586.356023298153, 8589.65641374338, 8693.956530217309, 8726.781830454036, 5963.850903727442, 5997.580169388101, 6359.96820015897, 6480.513961453004, 6483.967580162069, 7046.964765176142, 7217.097862767154, 7311.524750891175, 7316.012338334257, 7350.0, 6234.625922444487, 6399.456046236122, 6449.064885591469, 6450.838729031811, 6641.634710090992, 6440.742370305323, 6452.870942581216, 6479.902801458076, 6502.219733631994, 6510.3489651034515, 5911.733971971185, 6003.90994135097, 6008.969955150196, 6015.518758499397, 6016.067509536029, 4187.895302617459, 4189.07840275139, 4243.0, 4264.168487144977, 4357.063231405263, 4283.593058659422, 4333.9349909750745, 4343.022819865505, 4402.779861007001, 4473.485549161758], "value": 3890.909142523682, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.2745543952043, 283.724786956652, 289.331643902585, 298.2737035318997, 302.09070697201446, 4512.61642760365, 4658.394408726869, 4730.479647238805, 4743.501932297107, 4756.4054493188305, 4530.1166272576775, 4584.724916505003, 4650.255959046544, 4664.530672838062, 4692.178868697982, 3746.30693321735, 3753.3244016077097, 3765.548134223897, 3765.755225910321, 3807.638274363931, 3514.630963748808, 3783.81080945953, 3789.962100379002, 3791.128040550675, 3800.353939830222, 3446.931061378771, 3587.8923632290944, 3720.702343812502, 3720.8511659533588, 3722.32998060349, 3745.756525825813, 3748.100455890594, 3748.175401411685, 3751.0869456577207, 3754.662080412776, 3327.1183136468853, 3327.8169700666454, 3330.167458135466, 3336.7497437692027, 3338.2322065924973, 4570.794314255866, 4611.930821037688, 4641.118187544355, 4679.3916790816975, 4702.764861756898, 4229.196452673982, 4260.297050986584, 4261.509926358477, 4271.31658934569, 4294.613484786384, 4955.92018181367, 4958.206686930074, 4963.875903102416, 5024.19612861944, 5026.8240611578785, 3491.5635545556806, 3618.3848745713294, 3619.8914032579064, 3626.764260323097, 3647.434647629622, 5098.260752190911, 5128.358955130609, 5149.30484384607, 5173.379194496647, 5189.040027594907, 3692.593814680383, 3706.925861482809, 3709.27669104522, 3710.591834898159, 3725.3294407006456, 3769.5476542815036, 3772.4152756322815, 3789.6399842014966, 3794.1273507093524, 3797.8480860765812, 3951.407288906687, 4188.895277618084, 4191.622753952098, 4288.656907447396, 4302.139572085595, 4915.336429582032, 4920.803167873245, 4943.2585112233455, 4970.329005584272, 4999.700017998932, 1260.1997731440601, 1270.5807083662553, 1275.489804078376, 1279.6864768131868, 1280.6350190195749, 805.3758337288531, 832.238501770885, 896.5696465696371, 909.2634965677822, 930.6649606141918, 4348.652107831366, 4369.710935274102, 4375.518692943773, 4384.298512238091, 4397.120575884772, 5076.771545280471, 5081.415637201695, 5099.195442506681, 5100.770465329069, 5109.412417571953, 4219.430376899079, 4399.38408622793, 4403.9779801100785, 4414.183376075436, 4423.911521769546, 2688.8252263602803, 2712.742289482496, 2717.3750037491486, 2723.428080103161, 2724.4959682458807, 4804.111239420718, 4804.6876952997945, 4810.494898035656, 4810.807567697323, 4812.342619609052, 5025.6482046256415, 5231.398389185292, 5233.058049551041, 5255.63210575256, 5268.708111971305, 4797.425917691342, 4799.424069111659, 4799.616030717534, 4799.6400269979895, 4819.662623616383, 5093.796248150033, 5119.616028797781, 5132.6150538709, 5148.4851514849715, 5152.330197074356, 4812.326274321527, 5057.31726216956, 5060.240963855304, 5072.467390924047, 5103.362079740033, 4861.444337812008, 4882.1212181806195, 4928.827491037797, 4944.678595891256, 4945.653804233669, 3638.9636103638622, 3654.908627284339, 3664.706823454064, 3668.9816550917076, 3670.1742108025483, 5026.396832380138, 5097.796088156432, 5121.436641969306, 5133.666311689728, 5256.737163141751, 4969.552740253394, 4982.701037937735, 4991.850244492671, 4999.350084488993, 5036.169032109661, 4983.377077865267, 4987.301777751045, 4999.700017998932, 5049.560875150564, 5060.595152387727, 4770.737609431515, 4893.853184404474, 4951.8266860659705, 4974.701517908937, 4975.402951645826, 4745.928811067905, 4861.4963293904375, 4918.581920536794, 4968.950310496994, 5003.874903127451, 4885.438174609823, 4899.652595536256, 4930.0, 4952.2819191217795, 4959.652824302264], "value": 3765.61682999749, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.7334772700011, 605.8394525450753, 634.1185751804989, 663.5355251324071, 665.268204974528, 12736.235825850456, 12913.548025819098, 12948.805767913465, 13801.861981380183, 13824.930875345623, 12707.237565746062, 12939.611811645642, 12948.805767913489, 12960.092793504458, 12987.480500779957, 594.8423667728056, 738.2838646512887, 757.2389748302948, 760.4068826315455, 760.9923900760976, 612.6416046612737, 726.0597526203553, 737.8155461134717, 747.4058123791599, 751.9285667861544, 788.2157253532743, 790.115071120346, 790.5138339920936, 790.5533373643901, 790.6007466229546, 784.9843003139962, 785.3403141361256, 785.603270348476, 785.8781888807245, 786.4023342259924, 466.16323698960446, 466.5824087441721, 473.5051870794993, 473.9549742774431, 474.94300683917805, 11815.172937894351, 12179.817302740466, 12292.631221063382, 12498.375081245902, 12560.183588066746, 12318.260904345769, 13201.669958251025, 13281.335933203301, 13755.38100785467, 14096.0, 10405.271630985833, 10405.479726013744, 10453.0, 10492.213084018653, 10579.94710026445, 3263.1189578813587, 3267.7059064684054, 3273.5908011498564, 3278.065751260879, 3300.6576498324853, 61950.69024654893, 62039.0, 62174.0673889892, 62518.37481625171, 62945.685271573806, 10063.0, 10084.848727269096, 10332.225083118647, 10445.11216546587, 10525.368477891197, 19907.900460497603, 19979.60040799205, 20036.89981550083, 20125.698114528295, 20198.39404817858, 6349.873002539924, 6403.903941440882, 6464.0, 6605.471562275006, 6737.898931516032, 3250.317433338978, 3263.4452143135723, 3289.342131573695, 3341.2983273512837, 3394.253264281854, 2757.531219692657, 2844.687084420712, 2859.4138201668607, 2862.055521677841, 2870.956935645967, 456.74650568933896, 464.5609898645747, 465.6554149929028, 465.75315083006063, 467.0262502681878, 478.0820824017894, 484.6026258468093, 506.5694159964075, 524.3995625009419, 546.3307448375708, 7590.582517961455, 7647.4477848651395, 7882.566458844819, 7924.960375198087, 8448.619812108469, 514.2723046888685, 525.7949399734107, 532.3186321508398, 534.3134072716618, 537.1647088776912, 3981.203759248162, 4114.650254728382, 4138.482689663792, 4269.103488267437, 4284.935725964051, 92150.53924730333, 98852.0, 101694.49152754189, 102140.0, 102925.0, 83749.0, 84609.57695211485, 85103.5744821272, 85721.57139214264, 87309.5634521836, 74923.62538187383, 78241.99999999886, 78963.0, 79053.60473197597, 79819.60090199744, 7532.736354227576, 7809.492382995087, 7875.527468351917, 8020.0375954885785, 8144.959275203586, 44494.3325850119, 45839.31241031454, 47346.76326618345, 47965.0, 48761.41720867637, 64925.0, 67436.0, 67538.66230668816, 67956.32043679697, 69060.6546967262, 9917.900820991987, 10080.24398170155, 10112.646057387956, 10275.972402759964, 10377.0, 10746.83879741789, 10811.729706757395, 10892.292001019909, 10913.56345746193, 11289.71775705614, 9719.757006074904, 10145.543450544596, 10779.245452818228, 10785.298955567863, 10796.406197659204, 9863.0, 9899.356541824758, 9998.500074996076, 10178.796424071625, 10733.14134869193, 9854.507274636097, 9903.0, 10057.083445800636, 10366.274360794672, 10420.635277765241, 8351.791205219919, 8424.578771061544, 8630.439021463584, 8659.913400865911, 8765.868511972198, 8548.658053678031, 8901.51041692713, 9219.677311294072, 9297.488638124969, 9448.338616296793], "value": 6253.660805643031, "unit": "score"}], "name": "dromaeo_css", "value": 6076.868960855721, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 117.0, 114.0, 115.0, 113.0, 114.0, 113.0, 117.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 125.0, 173.0, 141.0, 127.0, 134.0, 132.0, 175.0, 132.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 163.0, 162.0, 162.0, 160.0, 160.0, 162.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 113.0, 77.0, 77.0, 77.0, 77.0, 99.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 122.0, 83.0, 84.0, 84.0, 109.0, 83.0, 83.0, 119.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 148.0, 148.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 97.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 63.0, 65.0, 64.0, 65.0, 64.0, 64.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 67.0, 66.0, 66.0, 65.0, 66.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 91.0, 83.0, 83.0, 82.0, 82.0, 83.0, 83.0, 82.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 147.0, 142.0, 139.0, 138.0, 144.0, 139.0, 147.0, 194.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 177.0, 173.0, 176.0, 175.0, 177.0, 179.0, 181.0, 177.0, 172.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 69.0, 74.0, 70.0, 70.0, 71.0, 69.0, 70.0, 72.0], "value": 70.8, "unit": "score"}], "name": "kraken", "value": 1561.3, "alertThreshold": 2.0}]} 09:57:30 INFO - Return code: 0 09:57:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:57:30 INFO - # TBPL SUCCESS # 09:57:30 INFO - Running post-action listener: _resource_record_post_action 09:57:30 INFO - [mozharness: 2016-10-11 16:57:30.160901Z] Finished run-tests step (success) 09:57:30 INFO - Running post-run listener: _resource_record_post_run 09:57:30 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394166272; Read time: 184; Write time: 276396 09:57:30 INFO - TinderboxPrint: CPU usage
13.0% 09:57:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 184 09:57:30 INFO - TinderboxPrint: I/O write bytes / time
394,166,272 / 276,396 09:57:30 INFO - TinderboxPrint: CPU idle
8,348.9 (87.0%) 09:57:30 INFO - TinderboxPrint: CPU user
1,203.5 (12.5%) 09:57:30 INFO - TinderboxPrint: Swap in / out
0 / 0 09:57:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99991552; Read time: 0; Write time: 102552 09:57:30 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294174720; Read time: 184; Write time: 173844 09:57:30 INFO - Running post-run listener: _upload_blobber_files 09:57:30 INFO - Blob upload gear active. 09:57:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:57:30 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 09:57:30 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:57:30 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:57:31 INFO - (blobuploader) - INFO - Open directory for files ... 09:57:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:57:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:57:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:57:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:57:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:57:32 INFO - (blobuploader) - INFO - Done attempting. 09:57:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:57:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:57:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:57:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:57:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:57:32 INFO - (blobuploader) - INFO - Done attempting. 09:57:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:57:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:57:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:57:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:57:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:57:37 INFO - (blobuploader) - INFO - Done attempting. 09:57:37 INFO - (blobuploader) - INFO - Iteration through files over. 09:57:37 INFO - Return code: 0 09:57:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:57:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:57:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f06927b6cb8190fcbf4d1566d274a993c5a9ec4b1edc8294342424c0c43ab83b122efa3a4cc7778891cae65461744d95f71bd5ef1bb69a0f92bf40c84815fb4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e9d46a3ee613962bee1e7664a758a14fe04e8dd6d638ecc6e0bcfc64b7c580622d55ea10453b99b9e1b7ee7009d40a0ae302f882ef9b26ca1a4db7c3a078524d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/740bc66bba49abdc7c1125c6dff7e70f6ccdcde612fd953921dd2fec125d85694fdfee4b5b7138e8a510e960bbbb304626181a50565c600bfdd8b066c104e49f"} 09:57:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:57:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:57:37 INFO - Contents: 09:57:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f06927b6cb8190fcbf4d1566d274a993c5a9ec4b1edc8294342424c0c43ab83b122efa3a4cc7778891cae65461744d95f71bd5ef1bb69a0f92bf40c84815fb4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e9d46a3ee613962bee1e7664a758a14fe04e8dd6d638ecc6e0bcfc64b7c580622d55ea10453b99b9e1b7ee7009d40a0ae302f882ef9b26ca1a4db7c3a078524d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/740bc66bba49abdc7c1125c6dff7e70f6ccdcde612fd953921dd2fec125d85694fdfee4b5b7138e8a510e960bbbb304626181a50565c600bfdd8b066c104e49f"} 09:57:37 INFO - Running post-run listener: copy_logs_to_upload_dir 09:57:37 INFO - Copying logs to upload dir... 09:57:37 INFO - mkdir: /builds/slave/test/build/upload/logs 09:57:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.481181 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-11 09:57:36.422441) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 09:57:36.428039) ========= 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-1476203718.910284-2042620551 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-Non-PGO/sha512/f06927b6cb8190fcbf4d1566d274a993c5a9ec4b1edc8294342424c0c43ab83b122efa3a4cc7778891cae65461744d95f71bd5ef1bb69a0f92bf40c84815fb4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e9d46a3ee613962bee1e7664a758a14fe04e8dd6d638ecc6e0bcfc64b7c580622d55ea10453b99b9e1b7ee7009d40a0ae302f882ef9b26ca1a4db7c3a078524d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/740bc66bba49abdc7c1125c6dff7e70f6ccdcde612fd953921dd2fec125d85694fdfee4b5b7138e8a510e960bbbb304626181a50565c600bfdd8b066c104e49f"} build_url:https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011494 build_url: 'https://queue.taskcluster.net/v1/task/AjqYwXBHSVWITki8qrg0aw/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-Non-PGO/sha512/f06927b6cb8190fcbf4d1566d274a993c5a9ec4b1edc8294342424c0c43ab83b122efa3a4cc7778891cae65461744d95f71bd5ef1bb69a0f92bf40c84815fb4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e9d46a3ee613962bee1e7664a758a14fe04e8dd6d638ecc6e0bcfc64b7c580622d55ea10453b99b9e1b7ee7009d40a0ae302f882ef9b26ca1a4db7c3a078524d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/740bc66bba49abdc7c1125c6dff7e70f6ccdcde612fd953921dd2fec125d85694fdfee4b5b7138e8a510e960bbbb304626181a50565c600bfdd8b066c104e49f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 09:57:36.453386) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 09:57:36.453760) ========= 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-1476203718.910284-2042620551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 09:57:36.537455) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 09:57:36.537774) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 09:57:36.538056) ========= ========= Total master_lag: 0.17 =========