builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1479145719.34 results: success (0) buildid: 20161114043455 builduid: d00525730d904e358afe39be231f63da revision: 7e29173b1641f54d08c60a64cd9d1b5fbc3bba2f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 09:48:39.336070) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 09:48:39.336556) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 09:48:39.336833) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 09:48:39.351198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 09:48:39.351538) ========= 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=d2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-14 09:48:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.4M=0s 2016-11-14 09:48:41 (42.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084992 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 09:48:39.450397) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 09:48:39.450743) ========= 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=d2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015079 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 09:48:39.500299) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 09:48:39.500746) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7e29173b1641f54d08c60a64cd9d1b5fbc3bba2f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7e29173b1641f54d08c60a64cd9d1b5fbc3bba2f --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=d2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-14 09:48:41,457 truncating revision to first 12 chars 2016-11-14 09:48:41,457 Setting DEBUG logging. 2016-11-14 09:48:41,457 attempt 1/10 2016-11-14 09:48:41,457 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7e29173b1641?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 09:48:42,832 unpacking tar archive at: mozilla-aurora-7e29173b1641/testing/mozharness/ program finished with exit code 0 elapsedTime=1.702615 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 09:48:41.218543) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 09:48:41.218901) ========= script_repo_revision: 7e29173b1641f54d08c60a64cd9d1b5fbc3bba2f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 09:48:41.219323) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 09:48:41.219607) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 09:48:41.229565) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-14 09:48:41.229991) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=d2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:48:43 INFO - MultiFileLogger online at 20161114 09:48:43 in /builds/slave/test 09:48:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:48:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:48:43 INFO - {'append_to_log': False, 09:48:43 INFO - 'base_work_dir': '/builds/slave/test', 09:48:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:48:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:48:43 INFO - 'branch': 'Mozilla-Aurora', 09:48:43 INFO - 'buildbot_json_path': 'buildprops.json', 09:48:43 INFO - 'config_files': ('talos/linux_config.py',), 09:48:43 INFO - 'default_actions': ('clobber', 09:48:43 INFO - 'read-buildbot-config', 09:48:43 INFO - 'download-and-extract', 09:48:43 INFO - 'populate-webroot', 09:48:43 INFO - 'create-virtualenv', 09:48:43 INFO - 'install', 09:48:43 INFO - 'run-tests'), 09:48:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:48:43 INFO - 'download_minidump_stackwalk': True, 09:48:43 INFO - 'download_symbols': 'ondemand', 09:48:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:48:43 INFO - 'tooltool.py': '/tools/tooltool.py', 09:48:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:48:43 INFO - '/tools/misc-python/virtualenv.py')}, 09:48:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:48:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:48:43 INFO - 'installer_path': 'installer.exe', 09:48:43 INFO - 'log_level': 'info', 09:48:43 INFO - 'log_name': 'talos', 09:48:43 INFO - 'log_to_console': True, 09:48:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:48:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:48:43 INFO - 'opt_config_files': (), 09:48:43 INFO - 'pip_index': False, 09:48:43 INFO - 'sps_profile': False, 09:48:43 INFO - 'sps_profile_interval': 0, 09:48:43 INFO - 'suite': 'dromaeojs', 09:48:43 INFO - 'system_bits': '32', 09:48:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:48:43 INFO - 'title': 'talos-linux64-ix-043', 09:48:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:48:43 INFO - 'use_talos_json': True, 09:48:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:48:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:48:43 INFO - 'work_dir': 'build'} 09:48:43 INFO - [mozharness: 2016-11-14 17:48:43.285953Z] Running clobber step. 09:48:43 INFO - Running pre-action listener: _resource_record_pre_action 09:48:43 INFO - Running main action method: clobber 09:48:43 INFO - rmtree: /builds/slave/test/build 09:48:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:48:44 INFO - Running post-action listener: _resource_record_post_action 09:48:44 INFO - [mozharness: 2016-11-14 17:48:44.264969Z] Finished clobber step (success) 09:48:44 INFO - [mozharness: 2016-11-14 17:48:44.265068Z] Running read-buildbot-config step. 09:48:44 INFO - Running pre-action listener: _resource_record_pre_action 09:48:44 INFO - Running main action method: read_buildbot_config 09:48:44 INFO - Using buildbot properties: 09:48:44 INFO - { 09:48:44 INFO - "project": "", 09:48:44 INFO - "product": "firefox", 09:48:44 INFO - "script_repo_revision": "production", 09:48:44 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:48:44 INFO - "repository": "", 09:48:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:48:44 INFO - "buildid": "20161114043455", 09:48:44 INFO - "stage_platform": "linux64-pgo", 09:48:44 INFO - "basedir": "/builds/slave/test", 09:48:44 INFO - "nightly_build": "True", 09:48:44 INFO - "buildnumber": 592, 09:48:44 INFO - "slavename": "talos-linux64-ix-043", 09:48:44 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:48:44 INFO - "platform": "ubuntu64_hw", 09:48:44 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:48:44 INFO - "branch": "mozilla-aurora", 09:48:44 INFO - "repo_path": "releases/mozilla-aurora", 09:48:44 INFO - "revision": "7e29173b1641f54d08c60a64cd9d1b5fbc3bba2f", 09:48:44 INFO - "pgo_build": "True", 09:48:44 INFO - "builduid": "d00525730d904e358afe39be231f63da", 09:48:44 INFO - "slavebuilddir": "test" 09:48:44 INFO - } 09:48:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 09:48:44 INFO - Running post-action listener: _resource_record_post_action 09:48:44 INFO - [mozharness: 2016-11-14 17:48:44.267568Z] Finished read-buildbot-config step (success) 09:48:44 INFO - [mozharness: 2016-11-14 17:48:44.267655Z] Running download-and-extract step. 09:48:44 INFO - Running pre-action listener: _resource_record_pre_action 09:48:44 INFO - Running main action method: download_and_extract 09:48:44 INFO - mkdir: /builds/slave/test/build/tests 09:48:44 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:48:44 INFO - trying https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:48:44 INFO - Downloading https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:48:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:48:44 INFO - Downloaded 1361 bytes. 09:48:44 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:48:44 INFO - Using the following test package requirements: 09:48:44 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:48:44 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:48:44 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:48:44 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:48:44 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:48:44 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:48:44 INFO - u'jsshell-linux-x86_64.zip'], 09:48:44 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:48:44 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:48:44 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:48:44 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:48:44 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:48:44 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:48:44 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:48:44 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:48:44 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:48:44 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:48:44 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:48:44 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:48:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:48:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:48:44 INFO - Fetch https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:48:45 INFO - Http code: 200 09:48:45 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 09:48:45 INFO - x-amz-cf-id: ZMV421jV-rFhon9n10OY2CB9LUyPiH329JXToHo3R59bQXqMUS0FoQ== 09:48:45 INFO - x-amz-version-id: .PupNpRub8iqci43oxfMUdKrecmEMiRk 09:48:45 INFO - Expected file size: 21999692 09:48:45 INFO - Obtained file size: 21999692 09:48:49 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:48:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:48:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:48:49 INFO - Fetch https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:48:50 INFO - Http code: 200 09:48:50 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 09:48:50 INFO - x-amz-cf-id: 68ko5Ipc9qoebZNamH3yKDNhCqF9YcQ8IY4o4bpW4jrFosjlCGN1cg== 09:48:50 INFO - x-amz-version-id: .PupNpRub8iqci43oxfMUdKrecmEMiRk 09:48:50 INFO - Expected file size: 21999692 09:48:50 INFO - Obtained file size: 21999692 09:48:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 09:48:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:48:55 INFO - Fetch https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:48:55 INFO - Http code: 200 09:48:55 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 09:48:55 INFO - x-amz-cf-id: xzqoTclIw0ckvcjV3HGW97hVjHVdFzTuKRbH5ZJQL5hAn4lT1uafFQ== 09:48:55 INFO - x-amz-version-id: khC2dBqT4macoa3mo70BLo5l_yQ3AZFc 09:48:55 INFO - Expected file size: 14409038 09:48:55 INFO - Obtained file size: 14409038 09:48:56 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:48:56 INFO - trying https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:48:56 INFO - Downloading https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:48:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:48:57 INFO - Downloaded 63922512 bytes. 09:48:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:48:57 INFO - mkdir: /builds/slave/test/properties 09:48:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:48:57 INFO - Writing to file /builds/slave/test/properties/build_url 09:48:57 INFO - Contents: 09:48:57 INFO - build_url:https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:48:58 INFO - Running post-action listener: _resource_record_post_action 09:48:58 INFO - Running post-action listener: set_extra_try_arguments 09:48:58 INFO - [mozharness: 2016-11-14 17:48:58.118948Z] Finished download-and-extract step (success) 09:48:58 INFO - [mozharness: 2016-11-14 17:48:58.119175Z] Running populate-webroot step. 09:48:58 INFO - Running pre-action listener: _resource_record_pre_action 09:48:58 INFO - Running main action method: populate_webroot 09:48:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:48:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:48:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:48:58 INFO - '--tppagecycles', 09:48:58 INFO - '7'], 09:48:58 INFO - 'tests': ['tsvgm']}}, 09:48:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:48:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:48:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:48:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:48:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:48:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:48:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:58 INFO - 'talos_options': ['--disable-e10s'], 09:48:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:58 INFO - 'talos_options': ['--disable-e10s'], 09:48:58 INFO - 'tests': ['damp', 'tps']}, 09:48:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:58 INFO - 'tests': ['damp', 'tps']}, 09:48:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:48:58 INFO - 'tests': ['dromaeo_dom']}, 09:48:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:48:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:48:58 INFO - 'tests': ['basic_compositor_video']}, 09:48:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:48:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:48:58 INFO - 'tests': ['a11yr', 09:48:58 INFO - 'ts_paint', 09:48:58 INFO - 'tpaint', 09:48:58 INFO - 'sessionrestore', 09:48:58 INFO - 'sessionrestore_no_auto_restore', 09:48:58 INFO - 'tabpaint']}, 09:48:58 INFO - 'other-e10s': {'tests': ['a11yr', 09:48:58 INFO - 'ts_paint', 09:48:58 INFO - 'tpaint', 09:48:58 INFO - 'sessionrestore', 09:48:58 INFO - 'sessionrestore_no_auto_restore', 09:48:58 INFO - 'tabpaint']}, 09:48:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:48:58 INFO - 'ts_paint', 09:48:58 INFO - 'tpaint', 09:48:58 INFO - 'sessionrestore', 09:48:58 INFO - 'sessionrestore_no_auto_restore', 09:48:58 INFO - 'tabpaint']}, 09:48:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:48:58 INFO - 'ts_paint', 09:48:58 INFO - 'tpaint', 09:48:58 INFO - 'sessionrestore', 09:48:58 INFO - 'sessionrestore_no_auto_restore', 09:48:58 INFO - 'tabpaint']}, 09:48:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:48:58 INFO - 'tests': ['a11yr', 09:48:58 INFO - 'ts_paint', 09:48:58 INFO - 'tpaint', 09:48:58 INFO - 'sessionrestore', 09:48:58 INFO - 'sessionrestore_no_auto_restore', 09:48:58 INFO - 'tabpaint']}, 09:48:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:48:58 INFO - 'tests': ['a11yr', 09:48:58 INFO - 'ts_paint', 09:48:58 INFO - 'tpaint', 09:48:58 INFO - 'sessionrestore', 09:48:58 INFO - 'sessionrestore_no_auto_restore', 09:48:58 INFO - 'tabpaint']}, 09:48:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:48:58 INFO - 'tests': ['tsvgx', 09:48:58 INFO - 'tsvgr_opacity', 09:48:58 INFO - 'tart', 09:48:58 INFO - 'tscrollx', 09:48:58 INFO - 'cart']}, 09:48:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:48:58 INFO - 'tsvgr_opacity', 09:48:58 INFO - 'tart', 09:48:58 INFO - 'tscrollx', 09:48:58 INFO - 'cart']}, 09:48:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:58 INFO - 'talos_options': ['--disable-e10s'], 09:48:58 INFO - 'tests': ['tp5o']}, 09:48:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:58 INFO - 'tests': ['tp5o']}, 09:48:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:58 INFO - 'talos_options': ['--disable-e10s', 09:48:58 INFO - '--xperf_path', 09:48:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:58 INFO - 'tests': ['tp5n']}, 09:48:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:58 INFO - 'talos_options': ['--xperf_path', 09:48:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:58 INFO - 'tests': ['tp5n']}}, 09:48:58 INFO - 'talos.zip': {'path': '', 09:48:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:48:58 INFO - Running post-action listener: _resource_record_post_action 09:48:58 INFO - [mozharness: 2016-11-14 17:48:58.137581Z] Finished populate-webroot step (success) 09:48:58 INFO - [mozharness: 2016-11-14 17:48:58.137669Z] Running create-virtualenv step. 09:48:58 INFO - Running pre-action listener: _resource_record_pre_action 09:48:58 INFO - Running main action method: create_virtualenv 09:48:58 INFO - Creating virtualenv /builds/slave/test/build/venv 09:48:58 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:48:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:48:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:48:58 INFO - Using real prefix '/usr' 09:48:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:48:58 INFO - Installing distribute.............................................................................................................................................................................................done. 09:49:00 INFO - Installing pip.................done. 09:49:00 INFO - Return code: 0 09:49:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:49:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:49:00 INFO - Reading from file tmpfile_stdout 09:49:00 INFO - Output received: 09:49:00 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:49:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:49: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:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:00 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 0x7f114fcc3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1809f60>, '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 0x180ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180b1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601', '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:49:00 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:49:00 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:49:00 INFO - Using env: {'DISPLAY': ':0', 09:49:00 INFO - 'HOME': '/home/cltbld', 09:49:00 INFO - 'LANG': 'en_US.UTF-8', 09:49:00 INFO - 'LANGUAGE': 'en_US:en', 09:49:00 INFO - 'LOGNAME': 'cltbld', 09:49:00 INFO - 'MAIL': '/var/mail/cltbld', 09:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:00 INFO - 'MOZ_NO_REMOTE': '1', 09:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:00 INFO - 'NO_EM_RESTART': '1', 09:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:00 INFO - 'PWD': '/builds/slave/test', 09:49:00 INFO - 'SHELL': '/bin/bash', 09:49:00 INFO - 'SHLVL': '1', 09:49:00 INFO - 'TERM': 'linux', 09:49:00 INFO - 'TMOUT': '86400', 09:49:00 INFO - 'USER': 'cltbld', 09:49:00 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601', 09:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:00 INFO - '_': '/tools/buildbot/bin/python'} 09:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:01 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:49:01 INFO - Cleaning up... 09:49:01 INFO - Return code: 0 09:49:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:49:01 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:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:01 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:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:01 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 0x7f114fcc3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1809f60>, '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 0x180ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180b1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601', '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:49:01 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:49:01 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:49:01 INFO - Using env: {'DISPLAY': ':0', 09:49:01 INFO - 'HOME': '/home/cltbld', 09:49:01 INFO - 'LANG': 'en_US.UTF-8', 09:49:01 INFO - 'LANGUAGE': 'en_US:en', 09:49:01 INFO - 'LOGNAME': 'cltbld', 09:49:01 INFO - 'MAIL': '/var/mail/cltbld', 09:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:01 INFO - 'MOZ_NO_REMOTE': '1', 09:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:01 INFO - 'NO_EM_RESTART': '1', 09:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:01 INFO - 'PWD': '/builds/slave/test', 09:49:01 INFO - 'SHELL': '/bin/bash', 09:49:01 INFO - 'SHLVL': '1', 09:49:01 INFO - 'TERM': 'linux', 09:49:01 INFO - 'TMOUT': '86400', 09:49:01 INFO - 'USER': 'cltbld', 09:49:01 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601', 09:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:01 INFO - '_': '/tools/buildbot/bin/python'} 09:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:01 INFO - Downloading/unpacking psutil>=3.1.1 09:49:01 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:49:01 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:49:01 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:49:01 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:49:01 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:49:01 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:49:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:49:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:03 INFO - Installing collected packages: psutil 09:49:03 INFO - Running setup.py install for psutil 09:49:03 INFO - building 'psutil._psutil_linux' extension 09:49:03 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:49:03 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:49:03 INFO - building 'psutil._psutil_posix' extension 09:49:03 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:49:03 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:49:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:03 INFO - Successfully installed psutil 09:49:03 INFO - Cleaning up... 09:49:03 INFO - Return code: 0 09:49:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:49:03 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:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:03 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:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:03 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 0x7f114fcc3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1809f60>, '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 0x180ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180b1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601', '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:49:03 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:49:03 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:49:03 INFO - Using env: {'DISPLAY': ':0', 09:49:03 INFO - 'HOME': '/home/cltbld', 09:49:03 INFO - 'LANG': 'en_US.UTF-8', 09:49:03 INFO - 'LANGUAGE': 'en_US:en', 09:49:03 INFO - 'LOGNAME': 'cltbld', 09:49:03 INFO - 'MAIL': '/var/mail/cltbld', 09:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:03 INFO - 'MOZ_NO_REMOTE': '1', 09:49:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:03 INFO - 'NO_EM_RESTART': '1', 09:49:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:03 INFO - 'PWD': '/builds/slave/test', 09:49:03 INFO - 'SHELL': '/bin/bash', 09:49:03 INFO - 'SHLVL': '1', 09:49:03 INFO - 'TERM': 'linux', 09:49:03 INFO - 'TMOUT': '86400', 09:49:03 INFO - 'USER': 'cltbld', 09:49:03 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601', 09:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:03 INFO - '_': '/tools/buildbot/bin/python'} 09:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:49:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:49:06 INFO - Installing collected packages: mozsystemmonitor 09:49:06 INFO - Running setup.py install for mozsystemmonitor 09:49:06 INFO - Successfully installed mozsystemmonitor 09:49:06 INFO - Cleaning up... 09:49:06 INFO - Return code: 0 09:49:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:49: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:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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', '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 0x7f114fcc3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1809f60>, '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 0x180ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180b1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601', '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:49: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:49: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 jsonschema==2.5.1 09:49:06 INFO - Using env: {'DISPLAY': ':0', 09:49:06 INFO - 'HOME': '/home/cltbld', 09:49:06 INFO - 'LANG': 'en_US.UTF-8', 09:49:06 INFO - 'LANGUAGE': 'en_US:en', 09:49:06 INFO - 'LOGNAME': 'cltbld', 09:49:06 INFO - 'MAIL': '/var/mail/cltbld', 09:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:06 INFO - 'MOZ_NO_REMOTE': '1', 09:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:06 INFO - 'NO_EM_RESTART': '1', 09:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:06 INFO - 'PWD': '/builds/slave/test', 09:49:06 INFO - 'SHELL': '/bin/bash', 09:49:06 INFO - 'SHLVL': '1', 09:49:06 INFO - 'TERM': 'linux', 09:49:06 INFO - 'TMOUT': '86400', 09:49:06 INFO - 'USER': 'cltbld', 09:49:06 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601', 09:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:06 INFO - '_': '/tools/buildbot/bin/python'} 09:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:06 INFO - Downloading/unpacking jsonschema==2.5.1 09:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:49:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:08 INFO - Downloading functools32-3.2.3-2.tar.gz 09:49:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:49:08 INFO - warning: no files found matching '*.txt' 09:49:08 INFO - no previously-included directories found matching 'build' 09:49:08 INFO - no previously-included directories found matching 'dist' 09:49:08 INFO - no previously-included directories found matching '.git*' 09:49:08 INFO - Installing collected packages: jsonschema, functools32 09:49:08 INFO - Running setup.py install for functools32 09:49:08 INFO - warning: no files found matching '*.txt' 09:49:08 INFO - no previously-included directories found matching 'build' 09:49:08 INFO - no previously-included directories found matching 'dist' 09:49:08 INFO - no previously-included directories found matching '.git*' 09:49:08 INFO - Successfully installed jsonschema functools32 09:49:08 INFO - Cleaning up... 09:49:08 INFO - Return code: 0 09:49:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:49:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f114fcc3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1809f60>, '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 0x180ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180b1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601', '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:49:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:49:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:49:08 INFO - Using env: {'DISPLAY': ':0', 09:49:08 INFO - 'HOME': '/home/cltbld', 09:49:08 INFO - 'LANG': 'en_US.UTF-8', 09:49:08 INFO - 'LANGUAGE': 'en_US:en', 09:49:08 INFO - 'LOGNAME': 'cltbld', 09:49:08 INFO - 'MAIL': '/var/mail/cltbld', 09:49:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:08 INFO - 'MOZ_NO_REMOTE': '1', 09:49:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:08 INFO - 'NO_EM_RESTART': '1', 09:49:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:08 INFO - 'PWD': '/builds/slave/test', 09:49:08 INFO - 'SHELL': '/bin/bash', 09:49:08 INFO - 'SHLVL': '1', 09:49:08 INFO - 'TERM': 'linux', 09:49:08 INFO - 'TMOUT': '86400', 09:49:08 INFO - 'USER': 'cltbld', 09:49:08 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601', 09:49:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:08 INFO - '_': '/tools/buildbot/bin/python'} 09:49:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:49:09 INFO - Cleaning up... 09:49:09 INFO - Return code: 0 09:49:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:49: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:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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:49:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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', '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 0x7f114fcc3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1809f60>, '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 0x180ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180b1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601', '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:49: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:49: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 blobuploader==1.2.4 09:49:09 INFO - Using env: {'DISPLAY': ':0', 09:49:09 INFO - 'HOME': '/home/cltbld', 09:49:09 INFO - 'LANG': 'en_US.UTF-8', 09:49:09 INFO - 'LANGUAGE': 'en_US:en', 09:49:09 INFO - 'LOGNAME': 'cltbld', 09:49:09 INFO - 'MAIL': '/var/mail/cltbld', 09:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:09 INFO - 'MOZ_NO_REMOTE': '1', 09:49:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:09 INFO - 'NO_EM_RESTART': '1', 09:49:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:09 INFO - 'PWD': '/builds/slave/test', 09:49:09 INFO - 'SHELL': '/bin/bash', 09:49:09 INFO - 'SHLVL': '1', 09:49:09 INFO - 'TERM': 'linux', 09:49:09 INFO - 'TMOUT': '86400', 09:49:09 INFO - 'USER': 'cltbld', 09:49:09 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601', 09:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:09 INFO - '_': '/tools/buildbot/bin/python'} 09:49:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:09 INFO - Downloading/unpacking blobuploader==1.2.4 09:49: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:49: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:49: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:49: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:49: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:49: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:49:11 INFO - Downloading blobuploader-1.2.4.tar.gz 09:49:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:49:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:49:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:12 INFO - Downloading docopt-0.6.1.tar.gz 09:49:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:49:12 INFO - Installing collected packages: blobuploader, requests, docopt 09:49:12 INFO - Running setup.py install for blobuploader 09:49:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:49:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:49:12 INFO - Running setup.py install for requests 09:49:12 INFO - Running setup.py install for docopt 09:49:12 INFO - Successfully installed blobuploader requests docopt 09:49:12 INFO - Cleaning up... 09:49:12 INFO - Return code: 0 09:49:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49: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:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:12 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 0x7f114fcc3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1809f60>, '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 0x180ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180b1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601', '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:49:12 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:49:12 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:49:12 INFO - Using env: {'DISPLAY': ':0', 09:49:12 INFO - 'HOME': '/home/cltbld', 09:49:12 INFO - 'LANG': 'en_US.UTF-8', 09:49:12 INFO - 'LANGUAGE': 'en_US:en', 09:49:12 INFO - 'LOGNAME': 'cltbld', 09:49:12 INFO - 'MAIL': '/var/mail/cltbld', 09:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:12 INFO - 'MOZ_NO_REMOTE': '1', 09:49:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:12 INFO - 'NO_EM_RESTART': '1', 09:49:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:12 INFO - 'PWD': '/builds/slave/test', 09:49:12 INFO - 'SHELL': '/bin/bash', 09:49:12 INFO - 'SHLVL': '1', 09:49:12 INFO - 'TERM': 'linux', 09:49:12 INFO - 'TMOUT': '86400', 09:49:12 INFO - 'USER': 'cltbld', 09:49:12 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601', 09:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:12 INFO - '_': '/tools/buildbot/bin/python'} 09:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:49:13 INFO - Running setup.py (path:/tmp/pip-pqbsh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:49:13 INFO - Running setup.py (path:/tmp/pip-71JxP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:49:13 INFO - Running setup.py (path:/tmp/pip-JNhzcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:49:13 INFO - Running setup.py (path:/tmp/pip-db5ruy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:49:13 INFO - Running setup.py (path:/tmp/pip-QolxKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:49:13 INFO - Running setup.py (path:/tmp/pip-HjcJoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:49:13 INFO - Running setup.py (path:/tmp/pip-9A9usG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:49:13 INFO - Running setup.py (path:/tmp/pip-ickjHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:49:13 INFO - Running setup.py (path:/tmp/pip-H598em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:49:13 INFO - Running setup.py (path:/tmp/pip-T58ztV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:49:13 INFO - Running setup.py (path:/tmp/pip-CURTme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:49:13 INFO - Running setup.py (path:/tmp/pip-nynmFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:49:13 INFO - Running setup.py (path:/tmp/pip-CDXIuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:49:14 INFO - Running setup.py (path:/tmp/pip-Gz21H7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:14 INFO - Running setup.py (path:/tmp/pip-6KKko1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:49:14 INFO - Running setup.py (path:/tmp/pip-G3jlGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:49:14 INFO - Running setup.py (path:/tmp/pip-XQAPD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:49:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:49:14 INFO - Running setup.py install for manifestparser 09:49:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:49:14 INFO - Running setup.py install for mozcrash 09:49:14 INFO - Running setup.py install for mozdebug 09:49:14 INFO - Running setup.py install for mozdevice 09:49:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:49:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:49:14 INFO - Running setup.py install for mozfile 09:49:14 INFO - Running setup.py install for mozhttpd 09:49:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:49:14 INFO - Running setup.py install for mozinfo 09:49:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:49:15 INFO - Running setup.py install for mozInstall 09:49:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:49:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:49:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:49:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:49:15 INFO - Running setup.py install for mozleak 09:49:15 INFO - Running setup.py install for mozlog 09:49:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:49:15 INFO - Running setup.py install for moznetwork 09:49:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:49:15 INFO - Running setup.py install for mozprocess 09:49:15 INFO - Running setup.py install for mozprofile 09:49:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:49:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:49:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:49:15 INFO - Running setup.py install for mozrunner 09:49:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:49:15 INFO - Running setup.py install for mozscreenshot 09:49:15 INFO - Running setup.py install for moztest 09:49:15 INFO - Running setup.py install for mozversion 09:49:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:49:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:49:16 INFO - Cleaning up... 09:49:16 INFO - Return code: 0 09:49:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:16 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 0x7f114fcc3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1809f60>, '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 0x180ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180b1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601', '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:49:16 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:49:16 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:49:16 INFO - Using env: {'DISPLAY': ':0', 09:49:16 INFO - 'HOME': '/home/cltbld', 09:49:16 INFO - 'LANG': 'en_US.UTF-8', 09:49:16 INFO - 'LANGUAGE': 'en_US:en', 09:49:16 INFO - 'LOGNAME': 'cltbld', 09:49:16 INFO - 'MAIL': '/var/mail/cltbld', 09:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:16 INFO - 'MOZ_NO_REMOTE': '1', 09:49:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:16 INFO - 'NO_EM_RESTART': '1', 09:49:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:16 INFO - 'PWD': '/builds/slave/test', 09:49:16 INFO - 'SHELL': '/bin/bash', 09:49:16 INFO - 'SHLVL': '1', 09:49:16 INFO - 'TERM': 'linux', 09:49:16 INFO - 'TMOUT': '86400', 09:49:16 INFO - 'USER': 'cltbld', 09:49:16 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601', 09:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:16 INFO - '_': '/tools/buildbot/bin/python'} 09:49:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:49:16 INFO - Running setup.py (path:/tmp/pip-UXWSI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:49:16 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:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:49:16 INFO - Running setup.py (path:/tmp/pip-HNJ5H9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:49:16 INFO - Running setup.py (path:/tmp/pip-GKQp6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:49:16 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:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:49:16 INFO - Running setup.py (path:/tmp/pip-Gsd77t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:49:16 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:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:49:16 INFO - Running setup.py (path:/tmp/pip-aa8UQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:49:16 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:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:49:16 INFO - Running setup.py (path:/tmp/pip-XzH4i7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:49:16 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:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:49:16 INFO - Running setup.py (path:/tmp/pip-YZ650D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:49:16 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:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:49:16 INFO - Running setup.py (path:/tmp/pip-60YA0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:49:16 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:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:49:16 INFO - Running setup.py (path:/tmp/pip-jyH88J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:49:16 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:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:49:16 INFO - Running setup.py (path:/tmp/pip-iF01FT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:49:17 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:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:49:17 INFO - Running setup.py (path:/tmp/pip-0vt8uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:49:17 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:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:49:17 INFO - Running setup.py (path:/tmp/pip-FmpBBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:49:17 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:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:49:17 INFO - Running setup.py (path:/tmp/pip-GNscqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:49:17 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:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:49:17 INFO - Running setup.py (path:/tmp/pip-BIWDX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:17 INFO - Running setup.py (path:/tmp/pip-TDeIUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:17 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:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:49:17 INFO - Running setup.py (path:/tmp/pip-YD3t9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:49:17 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:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:49:17 INFO - Running setup.py (path:/tmp/pip-Z6HquS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:49:17 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:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:49:17 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:49:17 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:49:17 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:49:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:49: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:49: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:49: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:49: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:49: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:49: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:49:19 INFO - Downloading blessings-1.6.tar.gz 09:49:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:49:19 INFO - Installing collected packages: blessings 09:49:19 INFO - Running setup.py install for blessings 09:49:19 INFO - Successfully installed blessings 09:49:19 INFO - Cleaning up... 09:49:19 INFO - Return code: 0 09:49:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:49:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:49:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:49:19 INFO - Reading from file tmpfile_stdout 09:49:19 INFO - Current package versions: 09:49:19 INFO - argparse == 1.2.1 09:49:19 INFO - blessings == 1.6 09:49:19 INFO - blobuploader == 1.2.4 09:49:19 INFO - docopt == 0.6.1 09:49:19 INFO - functools32 == 3.2.3-2 09:49:19 INFO - jsonschema == 2.5.1 09:49:19 INFO - manifestparser == 1.1 09:49:19 INFO - mozInstall == 1.12 09:49:19 INFO - mozcrash == 1.0 09:49:19 INFO - mozdebug == 0.1 09:49:19 INFO - mozdevice == 0.48 09:49:19 INFO - mozfile == 1.2 09:49:19 INFO - mozhttpd == 0.7 09:49:19 INFO - mozinfo == 0.9 09:49:19 INFO - mozleak == 0.1 09:49:19 INFO - mozlog == 3.4 09:49:19 INFO - moznetwork == 0.27 09:49:19 INFO - mozprocess == 0.23 09:49:19 INFO - mozprofile == 0.28 09:49:19 INFO - mozrunner == 6.13 09:49:19 INFO - mozscreenshot == 0.1 09:49:19 INFO - mozsystemmonitor == 0.3 09:49:19 INFO - moztest == 0.7 09:49:19 INFO - mozversion == 1.4 09:49:19 INFO - psutil == 3.1.1 09:49:19 INFO - requests == 1.2.3 09:49:19 INFO - wsgiref == 0.1.2 09:49:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:19 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 0x7f114fcc3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1809f60>, '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 0x180ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180b1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601', '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:49:20 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:49:20 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:49:20 INFO - Using env: {'DISPLAY': ':0', 09:49:20 INFO - 'HOME': '/home/cltbld', 09:49:20 INFO - 'LANG': 'en_US.UTF-8', 09:49:20 INFO - 'LANGUAGE': 'en_US:en', 09:49:20 INFO - 'LOGNAME': 'cltbld', 09:49:20 INFO - 'MAIL': '/var/mail/cltbld', 09:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:20 INFO - 'MOZ_NO_REMOTE': '1', 09:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:20 INFO - 'NO_EM_RESTART': '1', 09:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:20 INFO - 'PWD': '/builds/slave/test', 09:49:20 INFO - 'SHELL': '/bin/bash', 09:49:20 INFO - 'SHLVL': '1', 09:49:20 INFO - 'TERM': 'linux', 09:49:20 INFO - 'TMOUT': '86400', 09:49:20 INFO - 'USER': 'cltbld', 09:49:20 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601', 09:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:20 INFO - '_': '/tools/buildbot/bin/python'} 09:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:20 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:49:20 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:49:20 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:49:20 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:49:20 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:49:20 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:49:20 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:49:20 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:49:20 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:49:20 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:49:20 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:49:20 INFO - Cleaning up... 09:49:20 INFO - Return code: 0 09:49:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:20 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 0x7f114fcc3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1809f60>, '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 0x180ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180b1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601', '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:49:20 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:49:20 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:49:20 INFO - Using env: {'DISPLAY': ':0', 09:49:20 INFO - 'HOME': '/home/cltbld', 09:49:20 INFO - 'LANG': 'en_US.UTF-8', 09:49:20 INFO - 'LANGUAGE': 'en_US:en', 09:49:20 INFO - 'LOGNAME': 'cltbld', 09:49:20 INFO - 'MAIL': '/var/mail/cltbld', 09:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:20 INFO - 'MOZ_NO_REMOTE': '1', 09:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:20 INFO - 'NO_EM_RESTART': '1', 09:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:20 INFO - 'PWD': '/builds/slave/test', 09:49:20 INFO - 'SHELL': '/bin/bash', 09:49:20 INFO - 'SHLVL': '1', 09:49:20 INFO - 'TERM': 'linux', 09:49:20 INFO - 'TMOUT': '86400', 09:49:20 INFO - 'USER': 'cltbld', 09:49:20 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601', 09:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:20 INFO - '_': '/tools/buildbot/bin/python'} 09:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:49:20 INFO - Cleaning up... 09:49:20 INFO - Return code: 0 09:49:20 INFO - Running post-action listener: _resource_record_post_action 09:49:20 INFO - Running post-action listener: _start_resource_monitoring 09:49:20 INFO - Starting resource monitoring. 09:49:20 INFO - [mozharness: 2016-11-14 17:49:20.499399Z] Finished create-virtualenv step (success) 09:49:20 INFO - [mozharness: 2016-11-14 17:49:20.499913Z] Running install step. 09:49:20 INFO - Running pre-action listener: _resource_record_pre_action 09:49:20 INFO - Running main action method: install 09:49:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:49:20 INFO - Reading from file tmpfile_stdout 09:49:20 INFO - Detecting whether we're running mozinstall >=1.0... 09:49:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:49:20 INFO - Reading from file tmpfile_stdout 09:49:20 INFO - Output received: 09:49:20 INFO - Usage: mozinstall [options] installer 09:49:20 INFO - Options: 09:49:20 INFO - -h, --help show this help message and exit 09:49:20 INFO - -d DEST, --destination=DEST 09:49:20 INFO - Directory to install application into. [default: 09:49:20 INFO - "/builds/slave/test"] 09:49:20 INFO - --app=APP Application being installed. [default: firefox] 09:49:20 INFO - mkdir: /builds/slave/test/build/application 09:49:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:49:36 INFO - Reading from file tmpfile_stdout 09:49:36 INFO - Output received: 09:49:36 INFO - /builds/slave/test/build/application/firefox/firefox 09:49:36 INFO - Running post-action listener: _resource_record_post_action 09:49:36 INFO - [mozharness: 2016-11-14 17:49:36.701036Z] Finished install step (success) 09:49:36 INFO - [mozharness: 2016-11-14 17:49:36.701369Z] Running run-tests step. 09:49:36 INFO - Running pre-action listener: _resource_record_pre_action 09:49:36 INFO - Running main action method: run_tests 09:49:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:49:36 INFO - Python 2.7.3 09:49:36 INFO - Return code: 0 09:49:36 INFO - grabbing minidump binary from tooltool 09:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:36 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 0x1809f60>, '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 0x180ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180b1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:49:36 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:49:36 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:49:36 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:49:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:49:36 INFO - Return code: 0 09:49:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:49:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:49:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:49:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:49:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:49:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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:49:36 INFO - Using env: {'DISPLAY': ':0', 09:49:36 INFO - 'HOME': '/home/cltbld', 09:49:36 INFO - 'LANG': 'en_US.UTF-8', 09:49:36 INFO - 'LANGUAGE': 'en_US:en', 09:49:36 INFO - 'LOGNAME': 'cltbld', 09:49:36 INFO - 'MAIL': '/var/mail/cltbld', 09:49:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:49:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:36 INFO - 'MOZ_NO_REMOTE': '1', 09:49:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:36 INFO - 'NO_EM_RESTART': '1', 09:49:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:36 INFO - 'PWD': '/builds/slave/test', 09:49:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:49:36 INFO - 'SHELL': '/bin/bash', 09:49:36 INFO - 'SHLVL': '1', 09:49:36 INFO - 'TERM': 'linux', 09:49:36 INFO - 'TMOUT': '86400', 09:49:36 INFO - 'USER': 'cltbld', 09:49:36 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601', 09:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:36 INFO - '_': '/tools/buildbot/bin/python'} 09:49:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:49:36 INFO - mozversion application_buildid: 20161114043455 09:49:36 INFO - mozversion application_changeset: 7e29173b1641f54d08c60a64cd9d1b5fbc3bba2f 09:49:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:49:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:49:36 INFO - mozversion application_name: Firefox 09:49:36 INFO - mozversion application_remotingname: firefox-dev 09:49:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:49:36 INFO - mozversion application_vendor: Mozilla 09:49:36 INFO - mozversion application_version: 52.0a2 09:49:36 INFO - mozversion platform_buildid: 20161114043455 09:49:36 INFO - mozversion platform_changeset: 7e29173b1641f54d08c60a64cd9d1b5fbc3bba2f 09:49:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:49:36 INFO - mozversion platform_version: 52.0a2 09:49:36 INFO - using testdate: 1479145776 09:49:36 INFO - actual date: 1479145776 09:49:36 INFO - starting webserver on 'localhost:39957' 09:49:36 INFO - SUITE-START | Running 2 tests 09:49:36 INFO - TEST-START | dromaeo_css 09:49:36 INFO - operating with platform_type : linux_ 09:49:36 INFO - Initialising browser for dromaeo_css test... 09:49:36 INFO - TEST-INFO | started process 13008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjLKImb/profile http://localhost:39957/getInfo.html) 09:49:40 ERROR - PROCESS | 13008 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 09:49:41 INFO - PROCESS | 13008 | __metrics Screen width/height:1600/1200 09:49:41 INFO - PROCESS | 13008 | colorDepth:24 09:49:41 INFO - PROCESS | 13008 | Browser inner width/height: 1024/697 09:49:41 INFO - PROCESS | 13008 | __metrics 09:49:41 INFO - PROCESS | 13008 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:49:41 INFO - PROCESS | 13008 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:49:42 INFO - PROCESS | 13008 | console.error: PushService: 09:49:42 INFO - PROCESS | 13008 | stateChangeProcessEnqueue: Error transitioning state 09:49:42 INFO - PROCESS | 13008 | UnknownError 09:49:43 INFO - TEST-INFO | 13008: exit 0 09:49:43 INFO - Browser initialized. 09:49:43 INFO - Running cycle 1/1 for dromaeo_css test... 09:49:43 INFO - TEST-INFO | started process 13100 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjLKImb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:54 INFO - PROCESS | 13100 | RSS: Main: 144261120 09:49:54 INFO - PROCESS | 13100 | 09:50:46 INFO - PROCESS | 13100 | 1479145846438 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:52:56 INFO - PROCESS | 13100 | Cycle 1(1): loaded http://localhost:39957/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39957/tests/dromaeo/cssquery-ext.html) 09:52:57 INFO - PROCESS | 13100 | RSS: Main: 244408320 09:52:57 INFO - PROCESS | 13100 | 09:56:00 INFO - PROCESS | 13100 | Cycle 1(1): loaded http://localhost:39957/tests/dromaeo/cssquery-ext.html (next: http://localhost:39957/tests/dromaeo/cssquery-jquery.html) 09:56:00 INFO - PROCESS | 13100 | RSS: Main: 232079360 09:56:00 INFO - PROCESS | 13100 | 09:59:02 INFO - PROCESS | 13100 | Cycle 1(1): loaded http://localhost:39957/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39957/tests/dromaeo/cssquery-mootools.html) 09:59:03 INFO - PROCESS | 13100 | RSS: Main: 176013312 09:59:03 INFO - PROCESS | 13100 | 10:02:05 INFO - PROCESS | 13100 | Cycle 1(1): loaded http://localhost:39957/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39957/tests/dromaeo/cssquery-prototype.html) 10:02:05 INFO - PROCESS | 13100 | RSS: Main: 214609920 10:02:05 INFO - PROCESS | 13100 | 10:05:08 INFO - PROCESS | 13100 | Cycle 1(1): loaded http://localhost:39957/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39957/tests/dromaeo/cssquery-yui.html) 10:05:09 INFO - PROCESS | 13100 | RSS: Main: 175935488 10:05:09 INFO - PROCESS | 13100 | 10:08:11 INFO - PROCESS | 13100 | Cycle 1(1): loaded http://localhost:39957/tests/dromaeo/cssquery-yui.html (next: http://localhost:39957/tests/dromaeo/cssquery-dojo.html) 10:08:11 INFO - PROCESS | 13100 | RSS: Main: 270151680 10:08:11 INFO - PROCESS | 13100 | 10:08:11 INFO - PROCESS | 13100 | __start_tp_report 10:08:11 INFO - PROCESS | 13100 | _x_x_mozilla_page_load 10:08:11 INFO - PROCESS | 13100 | _x_x_mozilla_page_load_details 10:08:11 INFO - PROCESS | 13100 | |i|pagename|runs| 10:08:11 INFO - PROCESS | 13100 | |0;dojo.html;3116.096332063701;3153.4639111351066;3163.7943533670295;3175.2538153533915;3178.3643271345736;5410.648307859991;5478.91781623276;5481.150421684635;5498.642588231762;5513.2005859150395;5377.677339359641;5402.594805389602;5408.594355423339;5417.891642167155;5432.266644003058;4921.778519966601;4958.652894297401;4966.453690094087;4978.6763860348965;4993.525615066563;4825.806967721287;4843.055604157174;4958.776855041514;4997.100521906055;5036.924446133311;4899.706017638935;4915.6313276504225;4952.925706114411;4984.825531106412;4987.376577927759;4982.825601103962;5005.224190250517;5010.498950104979;5075.984803039407;5104.64267501275;4795.2087905495555;4968.652194346397;4988.176950803113;5023.673461225008;5045.192769156917;5243.79024839006;5263.36839579253;5269.6311258211945;5287;5321.175217841241;5650.660960342392;5657.321121465409;5687.829365119053;5738.598298119134;5757.222774925373;5621.80323688673;5782.190493330937;5792.536597072224;5801.419858014207;5803.564732645069;5330.466953304638;5389.487998640123;5409.107497262986;5446.482584154499;5506.311711036121;5921.052631579013;5955.225820643289;5958.940410595838;5964.522838172936;5965.224520812353;5504.091824848935;5715.714214289269;5726.226959360516;5726.914096288559;5731.77072917087;5653.236813030188;5760.164776107525;5817.214676018683;5819.359870414251;5923.674197919069;5851.063829787214;5853.414658534112;5854.297484301911;5854.853628659318;5890.558208134321;5795.130730390475;5851.034579294369;5857.297124345021;5857.326407463111;5859.648421094748;4405.933910991338;4435.578620031092;4458.977705111519;4502.16709908668;4514.6388288936805;4013.297672907288;4044.4135600338373;4050.4531888194715;4069.7354671946227;4074.959250407517;5582.888342233133;5589.580781441408;5591.888162236733;5600.831975040755;5631.324241091013;5598.356189038232;5650.519705824969;5709.115087161496;5729.5702822288495;5804.361520232771;5566.860828479321;5571.4428557143965;5574.16387541872;5578.497935185853;5605.299337582802;4995.400551933719;5009.524095210949;5011.123053465629;5013.623978201649;5044.646874718808;5774.162746401832;5851.38560451155;5934.228550288608;6080.543959203077;6088.573799833969;5738.22533957927;5804.767809287581;5825.271841019872;5864.06175011996;5867.237259156283;6048.848778780566;6052.213212282375;6053.152558641882;6053.606515576474;6058.12157237207;5543.584231182596;5599.020171469895;5692.857678558069;5696.917585658712;5698.20225168485;5671.064274394844;5747.626404283708;5750.769969201185;5801.709914504342;5841.737121829613;5635.126555383922;5686.175504551734;5688.857778555569;5695.231143795535;5695.544356451557;5462.289902312833;5653.773849046157;5665.405132461032;5669.7165141741925;5674.546036317002;5495.670259784426;5575.024370735024;5618.157276408408;5632.493075623213;5716.485516303553;5716.5998380113;5722.313322401338;5732.71336433185;5742.16738572913;5742.7702891883855;5325.893482130258;5383.919241211307;5389.730513474389;5532.114861622121;5591.30108736408 10:08:11 INFO - PROCESS | 13100 | |1;ext.html;579.8086631411632;614.198470995351;643.4916416031334;652.1456891472171;668.8762578922903;34289.65710342896;44625.553744462544;45439.318410223874;45444;45509.544904550945;46737.76631116848;47336.526634733644;47390.52609473904;47403;47465.762671186596;8684.739457816275;8812.779680508007;8815.867761983576;8832.11678832118;8832.646694132227;8735;8774.60514276859;8859.512726800023;8862.601182946783;8870.42342247755;8884.511351875644;8925.642974281054;8941.374103812735;8943.552822358888;8952.418092823946;8862.24670902974;8889.555522223864;8902.510361930092;8902.554872256362;8914.86627700585;8742.650293988232;8767.21095101444;8803.77990550235;8822.161894620001;8828.20546150843;43528.78235608833;43929.34105988413;44027.559724402665;44030.11939761219;44083.338749918774;3666.4866918631146;3764.887053388403;3778.6599206071587;4017.7589344639123;4323.718958267703;32525.837370812995;32668.346633067442;32980.17549561256;34026.31947361064;34132.82933585341;4243.257429949777;4250.256205164084;4361.149575832714;4368;4468.865934021985;359707;361811;362374;363081;363818;65120.67439662771;65484.67257663681;65588.6720566394;65657.67171164113;65740;35846.28307433889;36699;36719;68635.31364686388;68900.31099689039;18876.622467550573;19378.612427751366;19417.417477475698;19461.805381946284;19471.610567788564;14357;14707.632309192142;14714;14719.779203311959;14757.631059223606;20649.58700825975;20651;20799.480012999495;20887.58224835495;20910.16359345609;7093.955207110975;7135.928640713526;7243.74646887367;7254.746083887144;7312.378447831888;972.3728195313982;982.9066238707311;1059.3061544688242;1098.2751384086464;1147.892283945996;32942;32998.3400331992;33068.66931330704;33243.33513329768;33345.83327083349;1033.7829055898196;1083.6694808083453;1100.7468282294956;1121.4056550028497;1158.3976332307323;16017.519474415787;16858.15709214559;17001.659966800595;17018.31926722942;17132.657346852993;555207;564040;566209;566531;566764;60664.090038648574;61509.38490615126;61593.692031539555;61614;61647.691761540904;1245.7197130645714;1307;1312.0749871340872;1410.985890141106;1420.9413986580064;30262;32849.67150328466;35307.470387943686;35371.64628353684;35385.82307088448;54222.18666719923;54945;55219.171712423544;55269.723651381486;55301;500683;507313;507745;509044;510724;36715.81642091773;40475;40524.1895162101;43152.13695726005;46499.53500464952;50684.74657626836;50733;51184;51186;51620.74189629178;41207.1758564833;42867;43528.34707479327;44817;47022;43680.56319436765;44019;44593.55406445894;45080.77459612681;45392.31911521264;43878;44637.10725785401;44663.55336446724;44855;44941.325880112476;36411.81794091013;39053.80517654505;39440.2111957765;39813.40279895746;39826.402603960385;28895.729702491164;29059;29291.85354073216;29357;29612 10:08:11 INFO - PROCESS | 13100 | |2;jquery.html;418.19914863037275;431.1484817485465;433.172640257109;435.36248451938656;445.6880183871291;18677.719834202497;18814.99999999998;20207.09068091936;20292;20372.185112595515;18530;19267.518312042204;19352.322668706598;19458.805411945876;19927.900360498214;5251.264822924793;5495.6153069285165;5497.45025497449;5498.917516237259;5500.669959802424;5209.7134657593815;5365;5396.973015134939;5427.810026649068;5454.59090568207;5391.919121213185;5396.514313711785;5396.78412863485;5402.35171779387;5403.540699040586;5392.973035134799;5395.0558652235895;5397.541208997221;5435.864103397407;5678.034734095172;5200.219967004941;5203.323567936182;5204.193350030751;5205.583553315726;5206.0368831766245;15101.093934363864;15180.240987950558;15186;15214.923925380413;22421.66367504489;2372.1934542255717;2410.963835542468;2413.879306034709;2440.3777036855668;2803.2711495011445;10842.403667798268;10991.120710343153;11163.386013769239;11553.53785848565;14476.638084047878;1994.7406837111228;2027.2093883385492;2027.4627223785708;2063.587282543497;2096.465401322668;62950.37049629491;66611.66694166546;67876.66021889236;77262.61368693177;80282.59858700786;10929.508172132273;11279.943600281946;11622;11892.583759568373;11914.285142891282;17315;17333.913330433268;17343.046132462583;17348.566285842953;17355.04547249888;8672.523011234316;8696.304295656333;8807.647694092293;8873.467591944504;8908.465492070496;7851.60741962911;7883.2905038546805;8017.278444939867;8042.718504852302;8084.7574572762915;5088.491150884956;5143.228515722672;5207.635465517377;5218.6868787872845;5257;2009.1862795567818;2041.3875837248765;2059.4668557674145;2066.055870384696;2097.9370618881458;903.5346796399859;965.7295957132014;1034.8913364096811;1052.936823790575;1111.4109521953378;18818.15318310679;19983.300584479475;20294;20387.796122038886;20399.796002040086;994.2990191914682;1012.2104758288547;1029.8300780371305;1043.8329867221207;1076.7200527862656;10466.842997355046;10996.12031037515;11119.555217791198;11163.218574699855;11172.441377931233;464654.4805618867;468055;469907;474324;475816;62151.378486215464;88019.55990220008;95508.52245738727;96302.42880654303;97508.02491974989;994.4938754339025;1037.8391349340864;1041.7447725307347;1043.3009883378154;1050.7740835720356;17710.203040862936;18092.185851636972;18198.5450363742;18298.359557415428;18370.81629183691;39663.80168099141;42469.1506169881;43226.78386608047;43753.56246437495;44100;55303.17045244244;55518.16722749081;60037;60375;60391.69804150951;7444.851102977802;7960.283574478325;8047.195280471906;8393.034800997719;8572.142785721378;11892.286462812259;13318.533851315158;13330.133541319783;13497.662558436117;13575.592732217654;10991.725206869893;11592.768144637228;11832.585859494877;11842.585509507126;11916.344601047025;5615.354234263112;11128.332300062022;11182.776344473228;11506.712332191762;11576.24754390962;11465.828012579985;11505.769884602094;11676.591319304123;11862.762744745229;12020.75958480843;7792.4545281832;7950.761477155695;8055.1944805521325;8061.0326760789085;8206.876896846672;11114.44427778624;11173.441327933408;11315.151363647594;11315.886841131483;11813.940930295294 10:08:11 INFO - PROCESS | 13100 | |3;mootools.html;1251.3242848861614;1507.766296224085;1514.5380658899035;1660.3275673352289;1801.0904493230917;7610.1628820829665;8132.471389359687;8458.703945361905;8476.618552165151;8478.321734261259;8341.749747507585;8482.57587120643;8493.065762766091;8651.480911145336;8652.783680407993;2428.708554973401;2472.7032756069298;2473.9752602474014;2481.1068015514493;2481.1936120760734;2429.125514814665;2495.214007587604;2519.3575638212324;2519.5590771614984;2529.380301826046;2444.963325550118;2471.270975062361;2498.5502609530276;2499.125306142854;2502.2243104637528;2328.9184878529254;2358.6344116661858;2385.594448943684;2415.4444477770035;2419.395151212197;2342.8008619267384;2360.7521210273017;2382.583047966616;2383.809295256375;2384.5350156719446;8514.403991720583;8555.914440855575;8589.184027517376;8653.956730216372;8657.870131948026;5371.704556249405;5512.310961129859;5525.143602741541;5597.244372009767;5597.692126933017;3431.673990970854;3467.3474791784306;3536.0806190390686;3545.2023294758733;3721.4417837324618;1140.823172408278;1153.2158132469917;1161.384466232898;1168.452772954958;1178.723000094977;11830.704232394173;11996.520139194421;12047.698807529881;12048.096392770578;12058.276503409736;4775.450823155382;4904.6321525885705;4981.90036199274;4986.152354099811;5000.224965130411;10307.587696492206;10311;10312.896871031344;10317.793644127225;10328.586856525804;5570.997220500349;5572.5263352614675;5572.832815015556;5573.136163894603;5575.0522411190195;4280.400743895857;4453.844115456009;4596.080783843245;4988.27669987857;5132.640715149903;4251.744895306291;4253.21315556623;4315.525292217916;4333.783310834446;4369.148016136886;1412.4562043613282;1446.428660679047;1450.514077783933;1454.6945141520187;1469.5297504798361;898.9235914947172;999.3104757717297;1003.9799204015878;1011.367895065584;1015.4922538730634;5743.483086522233;5768.682722450221;5877.882442351129;5918.201042859159;5988.9101663475085;467.49744025172396;473.3562355196929;473.4295174314942;477.4294717812181;481.79523702426326;4133.627973482401;4163.375493675912;4212.620864122244;4223.873283801491;4227.2179646764835;10525.947405259412;10797.676069717922;10809.83785243222;10927.726806829734;10950.616728414467;10035.648752293635;10507.369557826554;10823.56705731762;10843.186760992958;10856.620018299322;8089.352851771844;8269.338452923752;8273.586320683942;8277.337812974947;8282.378821588405;5682.857928551819;5703.315602127771;5807.419258074159;5893.292804863272;5911.881762364815;9857.238956573563;9922.156616687662;10000.549975250986;10005.299629025898;10012.299139060196;9073.59168837417;9352.953235233781;10214.642487512901;10297.485125743833;10388.896111038794;7485.1017877855;7697.307242348215;7737.767866963775;7902.762917112495;7923.564203968606;8525.74422767318;8628.52543110135;8683.913160868311;8692.130786921258;8692.304615630861;7695.307422332017;7791.805204869924;7803.609819508888;7830.256125668053;7866.174051724486;7542.132654744774;7689.307962283421;7707;7733.149353570991;7889.802754930943;6910.20532638753;6955.130608673916;6963.373296403348;7002;7041.295870413122;5327.653702509325;5421.593380496557;5454.890902182014;5495.5878309127775;5535.8892822142525;5033.924491132562;5046.77289521965;5064.949350506447;5078.263651770547;5082.288479612931 10:08:11 INFO - PROCESS | 13100 | |4;prototype.html;361.9330423871584;364.34054361605496;368.2469350178883;374.76951674720056;375.6619042861426;5172.6379153459275;5302.708351040691;5335.653182543132;5356.812511562096;5360.571154307656;5022.748862556876;5124.333836601246;5157.5358217760395;5160.174372100465;5170.482951704827;4158.941324044595;4161.459010328653;4167.499900011988;4207.579242075799;4225.598568136023;4033.334499807528;4189.539150693421;4223.21870453967;4230.428892099573;4238.978805105986;4135.338345864662;4139.56534563871;4163.770992595406;4166.562510936354;4188.392683060954;4143.958560414402;4158.37624356346;4161.9803148228875;4172.436721042681;4179.185058913513;3472.8263586820813;3566.6076731559765;3585.713142948558;3594.238822976749;3719;5091.632390938232;5097.929434818692;5104.795808167669;5117.257997590328;5118.744062796883;4631.212693842055;4644.326572646981;4657.720536767804;4667.226453947478;4667.649926255544;5388;5389.191621256804;5424.403315635277;5432.891342173174;5501.982133305311;3930.4693866328253;3933.7639741615594;3954.940675889864;3956.4263181838473;3978.1645854370618;5712.857178570527;5714.257146570961;5776.364599894008;5779.595428320062;5783.5951483396175;3957.22834047358;4096.262672718939;4120.381942708617;4192.580741925783;4209.642180414638;4179.644730197967;4212.283911735012;4212.53662097169;4214.777714462772;4226.915461690749;4739.786709598076;4740.691855029481;4741.241401375763;4779.378680771547;4804.471508134103;5305.867353316198;5467.726613669301;5529.612927095065;5532.589189756586;5553.888922221533;1330.401319406271;1340.1690951610065;1377.8966577506726;1403.3123769353147;1413.250976982201;946.2571881073325;948.1558368972283;954.0364232125464;969.60730903984;975.9707208783748;5155.510226528474;5166.53841925903;5168.560672342818;5176.534111929869;5183.3261675981885;5291.497307755757;5327.174287985368;5341.732913354394;5366.275552800322;5380.435054319319;4930.7288099154175;5109.284700141983;5120.257562653394;5121.539061484485;5134.358205224347;2826.265171055499;2842.4173044525824;2845.146456063173;2850.7884149236493;2863.7136286371197;5553.305836770403;5590.385057643656;5614.326280846324;5623.634463759842;5626.877083218853;5341.839744807662;5491.835244942658;5501;5504.559635229172;5545.445455454423;5547.694876781816;5552.91670624941;5561.805336813192;5603.859903502445;5616.157576363578;5149.536541711264;5323.1749078892835;5345.518903298566;5397;5461.508464238238;5289.7355132244;5296.867578310573;5314.601404894571;5316.521513063843;5319.574434045189;5577.693226872561;5589.692566908859;5599.748011339581;5613.494785469327;5671.432856714296;3907.452956586137;3941.083598137415;3978.482797236341;3989.606236258222;4023.3562629979065;5339.225812257278;5355.866103347447;5358.892822143614;5376;5391.649542779707;5378.811741589182;5439.156930675752;5490.396056433869;5534.806281780279;5551.666899986014;5469.288992430958;5483.4516548344845;5498.862528436821;5520.447955204448;5531.502164805187;5247.737613119252;5427.375851777097;5452.836414907559;5472.91790623149;5480.26016487785;5500.477454641803;5500.559955203494;5517.36550296705;5531.197976293334;5534.4742249486235;5437.972810135924;5439.5648348132845;5440.020796256712;5458.781648734006;5473.28847249855 10:08:11 INFO - PROCESS | 13100 | |5;yui.html;801.070757920812;818.897637795276;835.9038710548286;854.8845905802717;894.2577660541751;14647.780283295759;15721.685566288668;15860.762088568652;15864.841351586481;15930.283137258823;14260.215688137148;14297.356618952146;14530.782038269408;14569.417223311055;14707.19110448925;721.7221369772649;848.4612271207766;855.7347222361088;856.4433118473012;858.1547176031604;722.7867779005206;730.9378702810268;731.3198725185575;823.6499487717726;849;901.6123067081153;903.4127816919022;906.3972458315212;908.1690253418114;908.2189317187214;900.8918929728442;903.1375036839802;903.814717982812;904.3036861616519;905;549.1104410854401;560.2548610348227;632.9050642403677;663.6714826161033;664.8869692152346;13943.511977080854;14756.335964881499;14775.70448591022;14800.333984970595;14810.259487025605;14567.49013784523;14823.851761482463;14983.32575034126;15007.249637518189;15063.698726025528;13366.866331336756;13402.664933376645;13414.664633384145;13545.255010974393;14161.150330980174;3826.712996525244;3938.330483817729;4422.29243321067;4461.687681862271;4552.430946131733;65184.3481565183;65886.67056664734;66040;66267.66866165686;67892.3210767891;11250.774984500264;11256.205267250223;11309.434528273554;11405.771884562262;11437.428128593538;18989.715154272697;19087.61824763497;19156.329528466715;19800.90099549493;19841;7526.5107767994905;7652.502587331805;8126.471779334324;8249.257566819015;8437.3599003736;4632.420947381577;4706.858794236178;4810.182269014206;4881.048195601895;4920.991196804646;3334.983325083359;3404.2170300830453;3427.143214196451;3441.7590768645955;3505.631908649555;628.6196850905136;639.1020616034479;641.9967900160469;646.747768370336;655.4297760948006;741.7144399406268;743.7694314762441;775.4223103787714;797.8125140591957;802.5465611929242;9550.283728720235;10182.694519164437;10270.794584108276;10577.31247468912;10651.360918344924;697.0346070692128;711.7971378157304;719.7948584653349;782.8590853646398;816.3510009542309;4779.5220477951925;4954.207326827763;4969.18008528596;4973.975130124399;4997.825076122318;89457.55271223732;90960;93799;94027.21698818576;95851.52074239583;60766.08850867241;79675.60162199152;80507;81681.18318816736;83870.58064709637;74575.62712186405;75396.62301688566;75719.24280757231;76486.61756691181;78097.60951195208;9198.2181514572;9248.260139188715;9408.43549387039;9450.574724137568;9582.377145485521;49044.50955490399;50090.99818003692;50452.49547504478;51051.9579216842;52388.47611523836;66251.33748662645;68125;68683.28291792746;69488;71706.64146679234;11606.24559403636;11849.52601895949;11993.160478766402;12128;12409.503619855104;13047.869521305045;13657.795133072814;13665.453381864614;13883.861161388257;13892.791608125684;12913;13204.669883252996;13321;13398.799018014543;13623;12125.211861228992;12711.110222284722;12745.936270318589;12848.614541563767;13177.209367437985;11945.283283003047;12564.748705025666;13405.530806421728;13443.126196797177;13560.59318220455;10604.946975265382;10874.619388321687;11058.557657693602;11065.557377705123;11385.544578216779;10706.304090234109;10892.128629709447;11115.166362523005;11220.270682405617;11294.378809165575 10:08:11 INFO - PROCESS | 13100 | __end_tp_report 10:08:11 INFO - PROCESS | 13100 | __start_cc_report 10:08:11 INFO - PROCESS | 13100 | _x_x_mozilla_cycle_collect,1070 10:08:11 INFO - PROCESS | 13100 | __end_cc_report 10:08:11 INFO - PROCESS | 13100 | __startTimestamp1479146891822__endTimestamp 10:08:11 INFO - PROCESS | 13100 | 10:08:11 INFO - PROCESS | 13100 | ------- Summary: start ------- 10:08:11 INFO - PROCESS | 13100 | Number of tests: 6 10:08:11 INFO - PROCESS | 13100 | 10:08:11 INFO - PROCESS | 13100 | [#0] dojo.html Cycles:165 Average:5390.72 Median:5598.36 stddev:595.73 (10.6%) stddev-sans-first:570.20 10:08:11 INFO - PROCESS | 13100 | Values: 3116.1 3153.5 3163.8 3175.3 3178.4 5410.6 5478.9 5481.2 5498.6 5513.2 5377.7 5402.6 5408.6 5417.9 5432.3 4921.8 4958.7 4966.5 4978.7 4993.5 4825.8 4843.1 4958.8 4997.1 5036.9 4899.7 4915.6 4952.9 4984.8 4987.4 4982.8 5005.2 5010.5 5076.0 5104.6 4795.2 4968.7 4988.2 5023.7 5045.2 5243.8 5263.4 5269.6 5287.0 5321.2 5650.7 5657.3 5687.8 5738.6 5757.2 5621.8 5782.2 5792.5 5801.4 5803.6 5330.5 5389.5 5409.1 5446.5 5506.3 5921.1 5955.2 5958.9 5964.5 5965.2 5504.1 5715.7 5726.2 5726.9 5731.8 5653.2 5760.2 5817.2 5819.4 5923.7 5851.1 5853.4 5854.3 5854.9 5890.6 5795.1 5851.0 5857.3 5857.3 5859.6 4405.9 4435.6 4459.0 4502.2 4514.6 4013.3 4044.4 4050.5 4069.7 4075.0 5582.9 5589.6 5591.9 5600.8 5631.3 5598.4 5650.5 5709.1 5729.6 5804.4 5566.9 5571.4 5574.2 5578.5 5605.3 4995.4 5009.5 5011.1 5013.6 5044.6 5774.2 5851.4 5934.2 6080.5 6088.6 5738.2 5804.8 5825.3 5864.1 5867.2 6048.8 6052.2 6053.2 6053.6 6058.1 5543.6 5599.0 5692.9 5696.9 5698.2 5671.1 5747.6 5750.8 5801.7 5841.7 5635.1 5686.2 5688.9 5695.2 5695.5 5462.3 5653.8 5665.4 5669.7 5674.5 5495.7 5575.0 5618.2 5632.5 5716.5 5716.6 5722.3 5732.7 5742.2 5742.8 5325.9 5383.9 5389.7 5532.1 5591.3 10:08:11 INFO - PROCESS | 13100 | 10:08:11 INFO - PROCESS | 13100 | [#1] ext.html Cycles:180 Average:64663.04 Median:44338.45 stddev:128723.38 (290.3%) stddev-sans-first:128994.56 10:08:11 INFO - PROCESS | 13100 | Values: 579.8 614.2 643.5 652.1 668.9 34289.7 44625.6 45439.3 45444.0 45509.5 46737.8 47336.5 47390.5 47403.0 47465.8 8684.7 8812.8 8815.9 8832.1 8832.6 8735.0 8774.6 8859.5 8862.6 8870.4 8884.5 8925.6 8941.4 8943.6 8952.4 8862.2 8889.6 8902.5 8902.6 8914.9 8742.7 8767.2 8803.8 8822.2 8828.2 43528.8 43929.3 44027.6 44030.1 44083.3 3666.5 3764.9 3778.7 4017.8 4323.7 32525.8 32668.3 32980.2 34026.3 34132.8 4243.3 4250.3 4361.1 4368.0 4468.9 359707.0 361811.0 362374.0 363081.0 363818.0 65120.7 65484.7 65588.7 65657.7 65740.0 35846.3 36699.0 36719.0 68635.3 68900.3 18876.6 19378.6 19417.4 19461.8 19471.6 14357.0 14707.6 14714.0 14719.8 14757.6 20649.6 20651.0 20799.5 20887.6 20910.2 7094.0 7135.9 7243.7 7254.7 7312.4 972.4 982.9 1059.3 1098.3 1147.9 32942.0 32998.3 33068.7 33243.3 33345.8 1033.8 1083.7 1100.7 1121.4 1158.4 16017.5 16858.2 17001.7 17018.3 17132.7 555207.0 564040.0 566209.0 566531.0 566764.0 60664.1 61509.4 61593.7 61614.0 61647.7 1245.7 1307.0 1312.1 1411.0 1420.9 30262.0 32849.7 35307.5 35371.6 35385.8 54222.2 54945.0 55219.2 55269.7 55301.0 500683.0 507313.0 507745.0 509044.0 510724.0 36715.8 40475.0 40524.2 43152.1 46499.5 50684.7 50733.0 51184.0 51186.0 51620.7 41207.2 42867.0 43528.3 44817.0 47022.0 43680.6 44019.0 44593.6 45080.8 45392.3 43878.0 44637.1 44663.6 44855.0 44941.3 36411.8 39053.8 39440.2 39813.4 39826.4 28895.7 29059.0 29291.9 29357.0 29612.0 10:08:11 INFO - PROCESS | 13100 | 10:08:11 INFO - PROCESS | 13100 | [#2] jquery.html Cycles:180 Average:28022.75 Median:2391.58 stddev:77494.55 (3240.3%) stddev-sans-first:77684.22 10:08:11 INFO - PROCESS | 13100 | Values: 418.2 431.1 433.2 435.4 445.7 18677.7 18815.0 20207.1 20292.0 20372.2 18530.0 19267.5 19352.3 19458.8 19927.9 5251.3 5495.6 5497.5 5498.9 5500.7 5209.7 5365.0 5397.0 5427.8 5454.6 5391.9 5396.5 5396.8 5402.4 5403.5 5393.0 5395.1 5397.5 5435.9 5678.0 5200.2 5203.3 5204.2 5205.6 5206.0 15101.1 15180.2 15186.0 15214.9 22421.7 2372.2 2411.0 2413.9 2440.4 2803.3 10842.4 10991.1 11163.4 11553.5 14476.6 1994.7 2027.2 2027.5 2063.6 2096.5 62950.4 66611.7 67876.7 77262.6 80282.6 10929.5 11279.9 11622.0 11892.6 11914.3 17315.0 17333.9 17343.0 17348.6 17355.0 8672.5 8696.3 8807.6 8873.5 8908.5 7851.6 7883.3 8017.3 8042.7 8084.8 5088.5 5143.2 5207.6 5218.7 5257.0 2009.2 2041.4 2059.5 2066.1 2097.9 903.5 965.7 1034.9 1052.9 1111.4 18818.2 19983.3 20294.0 20387.8 20399.8 994.3 1012.2 1029.8 1043.8 1076.7 10466.8 10996.1 11119.6 11163.2 11172.4 464654.5 468055.0 469907.0 474324.0 475816.0 62151.4 88019.6 95508.5 96302.4 97508.0 994.5 1037.8 1041.7 1043.3 1050.8 17710.2 18092.2 18198.5 18298.4 18370.8 39663.8 42469.2 43226.8 43753.6 44100.0 55303.2 55518.2 60037.0 60375.0 60391.7 7444.9 7960.3 8047.2 8393.0 8572.1 11892.3 13318.5 13330.1 13497.7 13575.6 10991.7 11592.8 11832.6 11842.6 11916.3 5615.4 11128.3 11182.8 11506.7 11576.2 11465.8 11505.8 11676.6 11862.8 12020.8 7792.5 7950.8 8055.2 8061.0 8206.9 11114.4 11173.4 11315.2 11315.9 11813.9 10:08:11 INFO - PROCESS | 13100 | 10:08:11 INFO - PROCESS | 13100 | [#3] mootools.html Cycles:180 Average:5798.71 Median:2626.44 stddev:3209.98 (122.2%) stddev-sans-first:3200.79 10:08:11 INFO - PROCESS | 13100 | Values: 1251.3 1507.8 1514.5 1660.3 1801.1 7610.2 8132.5 8458.7 8476.6 8478.3 8341.7 8482.6 8493.1 8651.5 8652.8 2428.7 2472.7 2474.0 2481.1 2481.2 2429.1 2495.2 2519.4 2519.6 2529.4 2445.0 2471.3 2498.6 2499.1 2502.2 2328.9 2358.6 2385.6 2415.4 2419.4 2342.8 2360.8 2382.6 2383.8 2384.5 8514.4 8555.9 8589.2 8654.0 8657.9 5371.7 5512.3 5525.1 5597.2 5597.7 3431.7 3467.3 3536.1 3545.2 3721.4 1140.8 1153.2 1161.4 1168.5 1178.7 11830.7 11996.5 12047.7 12048.1 12058.3 4775.5 4904.6 4981.9 4986.2 5000.2 10307.6 10311.0 10312.9 10317.8 10328.6 5571.0 5572.5 5572.8 5573.1 5575.1 4280.4 4453.8 4596.1 4988.3 5132.6 4251.7 4253.2 4315.5 4333.8 4369.1 1412.5 1446.4 1450.5 1454.7 1469.5 898.9 999.3 1004.0 1011.4 1015.5 5743.5 5768.7 5877.9 5918.2 5988.9 467.5 473.4 473.4 477.4 481.8 4133.6 4163.4 4212.6 4223.9 4227.2 10525.9 10797.7 10809.8 10927.7 10950.6 10035.6 10507.4 10823.6 10843.2 10856.6 8089.4 8269.3 8273.6 8277.3 8282.4 5682.9 5703.3 5807.4 5893.3 5911.9 9857.2 9922.2 10000.5 10005.3 10012.3 9073.6 9353.0 10214.6 10297.5 10388.9 7485.1 7697.3 7737.8 7902.8 7923.6 8525.7 8628.5 8683.9 8692.1 8692.3 7695.3 7791.8 7803.6 7830.3 7866.2 7542.1 7689.3 7707.0 7733.1 7889.8 6910.2 6955.1 6963.4 7002.0 7041.3 5327.7 5421.6 5454.9 5495.6 5535.9 5033.9 5046.8 5064.9 5078.3 5082.3 10:08:11 INFO - PROCESS | 13100 | 10:08:11 INFO - PROCESS | 13100 | [#4] prototype.html Cycles:180 Average:4580.80 Median:5179.93 stddev:1314.15 (25.4%) stddev-sans-first:1279.11 10:08:11 INFO - PROCESS | 13100 | Values: 361.9 364.3 368.2 374.8 375.7 5172.6 5302.7 5335.7 5356.8 5360.6 5022.7 5124.3 5157.5 5160.2 5170.5 4158.9 4161.5 4167.5 4207.6 4225.6 4033.3 4189.5 4223.2 4230.4 4239.0 4135.3 4139.6 4163.8 4166.6 4188.4 4144.0 4158.4 4162.0 4172.4 4179.2 3472.8 3566.6 3585.7 3594.2 3719.0 5091.6 5097.9 5104.8 5117.3 5118.7 4631.2 4644.3 4657.7 4667.2 4667.6 5388.0 5389.2 5424.4 5432.9 5502.0 3930.5 3933.8 3954.9 3956.4 3978.2 5712.9 5714.3 5776.4 5779.6 5783.6 3957.2 4096.3 4120.4 4192.6 4209.6 4179.6 4212.3 4212.5 4214.8 4226.9 4739.8 4740.7 4741.2 4779.4 4804.5 5305.9 5467.7 5529.6 5532.6 5553.9 1330.4 1340.2 1377.9 1403.3 1413.3 946.3 948.2 954.0 969.6 976.0 5155.5 5166.5 5168.6 5176.5 5183.3 5291.5 5327.2 5341.7 5366.3 5380.4 4930.7 5109.3 5120.3 5121.5 5134.4 2826.3 2842.4 2845.1 2850.8 2863.7 5553.3 5590.4 5614.3 5623.6 5626.9 5341.8 5491.8 5501.0 5504.6 5545.4 5547.7 5552.9 5561.8 5603.9 5616.2 5149.5 5323.2 5345.5 5397.0 5461.5 5289.7 5296.9 5314.6 5316.5 5319.6 5577.7 5589.7 5599.7 5613.5 5671.4 3907.5 3941.1 3978.5 3989.6 4023.4 5339.2 5355.9 5358.9 5376.0 5391.6 5378.8 5439.2 5490.4 5534.8 5551.7 5469.3 5483.5 5498.9 5520.4 5531.5 5247.7 5427.4 5452.8 5472.9 5480.3 5500.5 5500.6 5517.4 5531.2 5534.5 5438.0 5439.6 5440.0 5458.8 5473.3 10:08:11 INFO - PROCESS | 13100 | 10:08:11 INFO - PROCESS | 13100 | [#5] yui.html Cycles:180 Average:18734.92 Median:4937.60 stddev:25075.31 (507.8%) stddev-sans-first:25109.50 10:08:11 INFO - PROCESS | 13100 | Values: 801.1 818.9 835.9 854.9 894.3 14647.8 15721.7 15860.8 15864.8 15930.3 14260.2 14297.4 14530.8 14569.4 14707.2 721.7 848.5 855.7 856.4 858.2 722.8 730.9 731.3 823.6 849.0 901.6 903.4 906.4 908.2 908.2 900.9 903.1 903.8 904.3 905.0 549.1 560.3 632.9 663.7 664.9 13943.5 14756.3 14775.7 14800.3 14810.3 14567.5 14823.9 14983.3 15007.2 15063.7 13366.9 13402.7 13414.7 13545.3 14161.2 3826.7 3938.3 4422.3 4461.7 4552.4 65184.3 65886.7 66040.0 66267.7 67892.3 11250.8 11256.2 11309.4 11405.8 11437.4 18989.7 19087.6 19156.3 19800.9 19841.0 7526.5 7652.5 8126.5 8249.3 8437.4 4632.4 4706.9 4810.2 4881.0 4921.0 3335.0 3404.2 3427.1 3441.8 3505.6 628.6 639.1 642.0 646.7 655.4 741.7 743.8 775.4 797.8 802.5 9550.3 10182.7 10270.8 10577.3 10651.4 697.0 711.8 719.8 782.9 816.4 4779.5 4954.2 4969.2 4974.0 4997.8 89457.6 90960.0 93799.0 94027.2 95851.5 60766.1 79675.6 80507.0 81681.2 83870.6 74575.6 75396.6 75719.2 76486.6 78097.6 9198.2 9248.3 9408.4 9450.6 9582.4 49044.5 50091.0 50452.5 51052.0 52388.5 66251.3 68125.0 68683.3 69488.0 71706.6 11606.2 11849.5 11993.2 12128.0 12409.5 13047.9 13657.8 13665.5 13883.9 13892.8 12913.0 13204.7 13321.0 13398.8 13623.0 12125.2 12711.1 12745.9 12848.6 13177.2 11945.3 12564.7 13405.5 13443.1 13560.6 10604.9 10874.6 11058.6 11065.6 11385.5 10706.3 10892.1 11115.2 11220.3 11294.4 10:08:11 INFO - PROCESS | 13100 | -------- Summary: end -------- 10:08:11 INFO - PROCESS | 13100 | 10:08:12 INFO - TEST-INFO | 13100: exit 0 10:08:12 INFO - TEST-OK | dromaeo_css | took 1115634ms 10:08:12 INFO - TEST-START | kraken 10:08:12 INFO - operating with platform_type : linux_ 10:08:12 INFO - Initialising browser for kraken test... 10:08:12 INFO - TEST-INFO | started process 13415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG9tb9W/profile http://localhost:39957/getInfo.html) 10:08:15 ERROR - PROCESS | 13415 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 10:08:16 INFO - PROCESS | 13415 | __metrics Screen width/height:1600/1200 10:08:16 INFO - PROCESS | 13415 | colorDepth:24 10:08:16 INFO - PROCESS | 13415 | Browser inner width/height: 1024/697 10:08:16 INFO - PROCESS | 13415 | __metrics 10:08:17 INFO - PROCESS | 13415 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:08:17 INFO - PROCESS | 13415 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:08:17 INFO - PROCESS | 13415 | console.error: PushService: 10:08:17 INFO - PROCESS | 13415 | stateChangeProcessEnqueue: Error transitioning state 10:08:17 INFO - PROCESS | 13415 | UnknownError 10:08:18 INFO - TEST-INFO | 13415: exit 0 10:08:18 INFO - Browser initialized. 10:08:18 INFO - Running cycle 1/1 for kraken test... 10:08:18 INFO - TEST-INFO | started process 13509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG9tb9W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:30 INFO - PROCESS | 13509 | RSS: Main: 144617472 10:08:30 INFO - PROCESS | 13509 | 10:08:32 INFO - PROCESS | 13509 | Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39957/tests/kraken/driver.html?testName=audio-beat-detection) 10:08:33 INFO - PROCESS | 13509 | RSS: Main: 185565184 10:08:33 INFO - PROCESS | 13509 | 10:08:36 INFO - PROCESS | 13509 | Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39957/tests/kraken/driver.html?testName=audio-dft) 10:08:36 INFO - PROCESS | 13509 | RSS: Main: 175185920 10:08:36 INFO - PROCESS | 13509 | 10:08:39 INFO - PROCESS | 13509 | Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39957/tests/kraken/driver.html?testName=audio-fft) 10:08:40 INFO - PROCESS | 13509 | RSS: Main: 266350592 10:08:40 INFO - PROCESS | 13509 | 10:08:42 INFO - PROCESS | 13509 | Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39957/tests/kraken/driver.html?testName=audio-oscillator) 10:08:43 INFO - PROCESS | 13509 | RSS: Main: 172560384 10:08:43 INFO - PROCESS | 13509 | 10:08:45 INFO - PROCESS | 13509 | Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39957/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:08:45 INFO - PROCESS | 13509 | RSS: Main: 175538176 10:08:45 INFO - PROCESS | 13509 | 10:08:48 INFO - PROCESS | 13509 | Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39957/tests/kraken/driver.html?testName=imaging-darkroom) 10:08:49 INFO - PROCESS | 13509 | RSS: Main: 214089728 10:08:49 INFO - PROCESS | 13509 | 10:08:52 INFO - PROCESS | 13509 | Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39957/tests/kraken/driver.html?testName=imaging-desaturate) 10:08:53 INFO - PROCESS | 13509 | RSS: Main: 212631552 10:08:53 INFO - PROCESS | 13509 | 10:08:55 INFO - PROCESS | 13509 | Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39957/tests/kraken/driver.html?testName=json-parse-financial) 10:08:56 INFO - PROCESS | 13509 | RSS: Main: 211402752 10:08:56 INFO - PROCESS | 13509 | 10:08:58 INFO - PROCESS | 13509 | Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39957/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:08:58 INFO - PROCESS | 13509 | RSS: Main: 173998080 10:08:58 INFO - PROCESS | 13509 | 10:09:00 INFO - PROCESS | 13509 | Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39957/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:09:00 INFO - PROCESS | 13509 | RSS: Main: 179941376 10:09:00 INFO - PROCESS | 13509 | 10:09:02 INFO - PROCESS | 13509 | Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39957/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:09:03 INFO - PROCESS | 13509 | RSS: Main: 189939712 10:09:03 INFO - PROCESS | 13509 | 10:09:06 INFO - PROCESS | 13509 | Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39957/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:09:06 INFO - PROCESS | 13509 | RSS: Main: 198914048 10:09:06 INFO - PROCESS | 13509 | 10:09:09 INFO - PROCESS | 13509 | Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39957/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:09:10 INFO - PROCESS | 13509 | RSS: Main: 194768896 10:09:10 INFO - PROCESS | 13509 | 10:09:11 INFO - PROCESS | 13509 | Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39957/tests/kraken/driver.html?testName=ai-astar) 10:09:12 INFO - PROCESS | 13509 | RSS: Main: 246132736 10:09:12 INFO - PROCESS | 13509 | 10:09:12 INFO - PROCESS | 13509 | __start_tp_report 10:09:12 INFO - PROCESS | 13509 | _x_x_mozilla_page_load 10:09:12 INFO - PROCESS | 13509 | _x_x_mozilla_page_load_details 10:09:12 INFO - PROCESS | 13509 | |i|pagename|runs| 10:09:12 INFO - PROCESS | 13509 | |0;ai-astar;111;113;112;112;111;111;112;111;113;113 10:09:12 INFO - PROCESS | 13509 | |1;audio-beat-detection;148;119;124;161;122;120;128;119;152;119 10:09:12 INFO - PROCESS | 13509 | |2;audio-dft;160;161;162;160;160;160;161;160;161;161 10:09:12 INFO - PROCESS | 13509 | |3;audio-fft;76;76;74;105;75;76;76;74;99;76 10:09:12 INFO - PROCESS | 13509 | |4;audio-oscillator;83;81;119;82;82;82;98;82;82;117 10:09:12 INFO - PROCESS | 13509 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;116;117 10:09:12 INFO - PROCESS | 13509 | |6;imaging-darkroom;147;146;146;145;147;145;146;153;146;145 10:09:12 INFO - PROCESS | 13509 | |7;imaging-desaturate;84;84;85;85;85;85;84;85;85;85 10:09:12 INFO - PROCESS | 13509 | |8;json-parse-financial;52;50;51;49;49;49;51;49;49;51 10:09:12 INFO - PROCESS | 13509 | |9;json-stringify-tinderbox;59;60;59;60;61;59;59;60;59;59 10:09:12 INFO - PROCESS | 13509 | |10;stanford-crypto-aes;75;74;75;75;74;75;75;76;77;83 10:09:12 INFO - PROCESS | 13509 | |11;stanford-crypto-ccm;127;141;128;135;126;138;125;126;174;126 10:09:12 INFO - PROCESS | 13509 | |12;stanford-crypto-pbkdf2;156;158;154;155;156;156;157;157;153;156 10:09:12 INFO - PROCESS | 13509 | |13;stanford-crypto-sha256-iterative;62;63;62;63;60;64;65;64;60;62 10:09:12 INFO - PROCESS | 13509 | __end_tp_report 10:09:12 INFO - PROCESS | 13509 | __start_cc_report 10:09:12 INFO - PROCESS | 13509 | _x_x_mozilla_cycle_collect,1635 10:09:12 INFO - PROCESS | 13509 | __end_cc_report 10:09:12 INFO - PROCESS | 13509 | __startTimestamp1479146952013__endTimestamp 10:09:12 INFO - PROCESS | 13509 | 10:09:12 INFO - PROCESS | 13509 | ------- Summary: start ------- 10:09:12 INFO - PROCESS | 13509 | Number of tests: 14 10:09:12 INFO - PROCESS | 13509 | 10:09:12 INFO - PROCESS | 13509 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:0.88 (0.8%) stddev-sans-first:0.87 10:09:12 INFO - PROCESS | 13509 | Values: 111.0 113.0 112.0 112.0 111.0 111.0 112.0 111.0 113.0 113.0 10:09:12 INFO - PROCESS | 13509 | 10:09:12 INFO - PROCESS | 13509 | [#1] audio-beat-detection Cycles:10 Average:131.20 Median:126.00 stddev:16.06 (12.7%) stddev-sans-first:15.84 10:09:12 INFO - PROCESS | 13509 | Values: 148.0 119.0 124.0 161.0 122.0 120.0 128.0 119.0 152.0 119.0 10:09:12 INFO - PROCESS | 13509 | 10:09:12 INFO - PROCESS | 13509 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 10:09:12 INFO - PROCESS | 13509 | Values: 160.0 161.0 162.0 160.0 160.0 160.0 161.0 160.0 161.0 161.0 10:09:12 INFO - PROCESS | 13509 | 10:09:12 INFO - PROCESS | 13509 | [#3] audio-fft Cycles:10 Average:80.70 Median:76.00 stddev:11.34 (14.9%) stddev-sans-first:11.90 10:09:12 INFO - PROCESS | 13509 | Values: 76.0 76.0 74.0 105.0 75.0 76.0 76.0 74.0 99.0 76.0 10:09:12 INFO - PROCESS | 13509 | 10:09:12 INFO - PROCESS | 13509 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:82.00 stddev:15.19 (18.5%) stddev-sans-first:15.85 10:09:12 INFO - PROCESS | 13509 | Values: 83.0 81.0 119.0 82.0 82.0 82.0 98.0 82.0 82.0 117.0 10:09:12 INFO - PROCESS | 13509 | 10:09:12 INFO - PROCESS | 13509 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 10:09:12 INFO - PROCESS | 13509 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 116.0 117.0 10:09:12 INFO - PROCESS | 13509 | 10:09:12 INFO - PROCESS | 13509 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.00 stddev:2.37 (1.6%) stddev-sans-first:2.51 10:09:12 INFO - PROCESS | 13509 | Values: 147.0 146.0 146.0 145.0 147.0 145.0 146.0 153.0 146.0 145.0 10:09:12 INFO - PROCESS | 13509 | 10:09:12 INFO - PROCESS | 13509 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 10:09:12 INFO - PROCESS | 13509 | Values: 84.0 84.0 85.0 85.0 85.0 85.0 84.0 85.0 85.0 85.0 10:09:12 INFO - PROCESS | 13509 | 10:09:12 INFO - PROCESS | 13509 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:50.50 stddev:1.15 (2.3%) stddev-sans-first:0.97 10:09:12 INFO - PROCESS | 13509 | Values: 52.0 50.0 51.0 49.0 49.0 49.0 51.0 49.0 49.0 51.0 10:09:12 INFO - PROCESS | 13509 | 10:09:12 INFO - PROCESS | 13509 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:59.50 stddev:0.71 (1.2%) stddev-sans-first:0.73 10:09:12 INFO - PROCESS | 13509 | Values: 59.0 60.0 59.0 60.0 61.0 59.0 59.0 60.0 59.0 59.0 10:09:12 INFO - PROCESS | 13509 | 10:09:12 INFO - PROCESS | 13509 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:75.00 stddev:2.64 (3.5%) stddev-sans-first:2.78 10:09:12 INFO - PROCESS | 13509 | Values: 75.0 74.0 75.0 75.0 74.0 75.0 75.0 76.0 77.0 83.0 10:09:12 INFO - PROCESS | 13509 | 10:09:12 INFO - PROCESS | 13509 | [#11] stanford-crypto-ccm Cycles:10 Average:134.60 Median:131.50 stddev:14.98 (11.4%) stddev-sans-first:15.64 10:09:12 INFO - PROCESS | 13509 | Values: 127.0 141.0 128.0 135.0 126.0 138.0 125.0 126.0 174.0 126.0 10:09:12 INFO - PROCESS | 13509 | 10:09:12 INFO - PROCESS | 13509 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.80 Median:156.00 stddev:1.48 (0.9%) stddev-sans-first:1.56 10:09:12 INFO - PROCESS | 13509 | Values: 156.0 158.0 154.0 155.0 156.0 156.0 157.0 157.0 153.0 156.0 10:09:12 INFO - PROCESS | 13509 | 10:09:12 INFO - PROCESS | 13509 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:63.00 stddev:1.65 (2.6%) stddev-sans-first:1.74 10:09:12 INFO - PROCESS | 13509 | Values: 62.0 63.0 62.0 63.0 60.0 64.0 65.0 64.0 60.0 62.0 10:09:12 INFO - PROCESS | 13509 | -------- Summary: end -------- 10:09:12 INFO - PROCESS | 13509 | 10:09:13 INFO - TEST-INFO | 13509: exit 0 10:09:13 INFO - TEST-OK | kraken | took 60452ms 10:09:13 INFO - SUITE-END | took 1176s 10:09:13 INFO - Completed test suite (00:19:36) 10:09:13 INFO - javascript benchmark 10:09:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3116.096332063701, 3153.4639111351066, 3163.7943533670295, 3175.2538153533915, 3178.3643271345736, 5410.648307859991, 5478.91781623276, 5481.150421684635, 5498.642588231762, 5513.2005859150395, 5377.677339359641, 5402.594805389602, 5408.594355423339, 5417.891642167155, 5432.266644003058, 4921.778519966601, 4958.652894297401, 4966.453690094087, 4978.6763860348965, 4993.525615066563, 4825.806967721287, 4843.055604157174, 4958.776855041514, 4997.100521906055, 5036.924446133311, 4899.706017638935, 4915.6313276504225, 4952.925706114411, 4984.825531106412, 4987.376577927759, 4982.825601103962, 5005.224190250517, 5010.498950104979, 5075.984803039407, 5104.64267501275, 4795.2087905495555, 4968.652194346397, 4988.176950803113, 5023.673461225008, 5045.192769156917, 5243.79024839006, 5263.36839579253, 5269.6311258211945, 5287.0, 5321.175217841241, 5650.660960342392, 5657.321121465409, 5687.829365119053, 5738.598298119134, 5757.222774925373, 5621.80323688673, 5782.190493330937, 5792.536597072224, 5801.419858014207, 5803.564732645069, 5330.466953304638, 5389.487998640123, 5409.107497262986, 5446.482584154499, 5506.311711036121, 5921.052631579013, 5955.225820643289, 5958.940410595838, 5964.522838172936, 5965.224520812353, 5504.091824848935, 5715.714214289269, 5726.226959360516, 5726.914096288559, 5731.77072917087, 5653.236813030188, 5760.164776107525, 5817.214676018683, 5819.359870414251, 5923.674197919069, 5851.063829787214, 5853.414658534112, 5854.297484301911, 5854.853628659318, 5890.558208134321, 5795.130730390475, 5851.034579294369, 5857.297124345021, 5857.326407463111, 5859.648421094748, 4405.933910991338, 4435.578620031092, 4458.977705111519, 4502.16709908668, 4514.6388288936805, 4013.297672907288, 4044.4135600338373, 4050.4531888194715, 4069.7354671946227, 4074.959250407517, 5582.888342233133, 5589.580781441408, 5591.888162236733, 5600.831975040755, 5631.324241091013, 5598.356189038232, 5650.519705824969, 5709.115087161496, 5729.5702822288495, 5804.361520232771, 5566.860828479321, 5571.4428557143965, 5574.16387541872, 5578.497935185853, 5605.299337582802, 4995.400551933719, 5009.524095210949, 5011.123053465629, 5013.623978201649, 5044.646874718808, 5774.162746401832, 5851.38560451155, 5934.228550288608, 6080.543959203077, 6088.573799833969, 5738.22533957927, 5804.767809287581, 5825.271841019872, 5864.06175011996, 5867.237259156283, 6048.848778780566, 6052.213212282375, 6053.152558641882, 6053.606515576474, 6058.12157237207, 5543.584231182596, 5599.020171469895, 5692.857678558069, 5696.917585658712, 5698.20225168485, 5671.064274394844, 5747.626404283708, 5750.769969201185, 5801.709914504342, 5841.737121829613, 5635.126555383922, 5686.175504551734, 5688.857778555569, 5695.231143795535, 5695.544356451557, 5462.289902312833, 5653.773849046157, 5665.405132461032, 5669.7165141741925, 5674.546036317002, 5495.670259784426, 5575.024370735024, 5618.157276408408, 5632.493075623213, 5716.485516303553, 5716.5998380113, 5722.313322401338, 5732.71336433185, 5742.16738572913, 5742.7702891883855, 5325.893482130258, 5383.919241211307, 5389.730513474389, 5532.114861622121, 5591.30108736408], "value": 5351.664010177401, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.8086631411632, 614.198470995351, 643.4916416031334, 652.1456891472171, 668.8762578922903, 34289.65710342896, 44625.553744462544, 45439.318410223874, 45444.0, 45509.544904550945, 46737.76631116848, 47336.526634733644, 47390.52609473904, 47403.0, 47465.762671186596, 8684.739457816275, 8812.779680508007, 8815.867761983576, 8832.11678832118, 8832.646694132227, 8735.0, 8774.60514276859, 8859.512726800023, 8862.601182946783, 8870.42342247755, 8884.511351875644, 8925.642974281054, 8941.374103812735, 8943.552822358888, 8952.418092823946, 8862.24670902974, 8889.555522223864, 8902.510361930092, 8902.554872256362, 8914.86627700585, 8742.650293988232, 8767.21095101444, 8803.77990550235, 8822.161894620001, 8828.20546150843, 43528.78235608833, 43929.34105988413, 44027.559724402665, 44030.11939761219, 44083.338749918774, 3666.4866918631146, 3764.887053388403, 3778.6599206071587, 4017.7589344639123, 4323.718958267703, 32525.837370812995, 32668.346633067442, 32980.17549561256, 34026.31947361064, 34132.82933585341, 4243.257429949777, 4250.256205164084, 4361.149575832714, 4368.0, 4468.865934021985, 359707.0, 361811.0, 362374.0, 363081.0, 363818.0, 65120.67439662771, 65484.67257663681, 65588.6720566394, 65657.67171164113, 65740.0, 35846.28307433889, 36699.0, 36719.0, 68635.31364686388, 68900.31099689039, 18876.622467550573, 19378.612427751366, 19417.417477475698, 19461.805381946284, 19471.610567788564, 14357.0, 14707.632309192142, 14714.0, 14719.779203311959, 14757.631059223606, 20649.58700825975, 20651.0, 20799.480012999495, 20887.58224835495, 20910.16359345609, 7093.955207110975, 7135.928640713526, 7243.74646887367, 7254.746083887144, 7312.378447831888, 972.3728195313982, 982.9066238707311, 1059.3061544688242, 1098.2751384086464, 1147.892283945996, 32942.0, 32998.3400331992, 33068.66931330704, 33243.33513329768, 33345.83327083349, 1033.7829055898196, 1083.6694808083453, 1100.7468282294956, 1121.4056550028497, 1158.3976332307323, 16017.519474415787, 16858.15709214559, 17001.659966800595, 17018.31926722942, 17132.657346852993, 555207.0, 564040.0, 566209.0, 566531.0, 566764.0, 60664.090038648574, 61509.38490615126, 61593.692031539555, 61614.0, 61647.691761540904, 1245.7197130645714, 1307.0, 1312.0749871340872, 1410.985890141106, 1420.9413986580064, 30262.0, 32849.67150328466, 35307.470387943686, 35371.64628353684, 35385.82307088448, 54222.18666719923, 54945.0, 55219.171712423544, 55269.723651381486, 55301.0, 500683.0, 507313.0, 507745.0, 509044.0, 510724.0, 36715.81642091773, 40475.0, 40524.1895162101, 43152.13695726005, 46499.53500464952, 50684.74657626836, 50733.0, 51184.0, 51186.0, 51620.74189629178, 41207.1758564833, 42867.0, 43528.34707479327, 44817.0, 47022.0, 43680.56319436765, 44019.0, 44593.55406445894, 45080.77459612681, 45392.31911521264, 43878.0, 44637.10725785401, 44663.55336446724, 44855.0, 44941.325880112476, 36411.81794091013, 39053.80517654505, 39440.2111957765, 39813.40279895746, 39826.402603960385, 28895.729702491164, 29059.0, 29291.85354073216, 29357.0, 29612.0], "value": 21145.013174347234, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.19914863037275, 431.1484817485465, 433.172640257109, 435.36248451938656, 445.6880183871291, 18677.719834202497, 18814.99999999998, 20207.09068091936, 20292.0, 20372.185112595515, 18530.0, 19267.518312042204, 19352.322668706598, 19458.805411945876, 19927.900360498214, 5251.264822924793, 5495.6153069285165, 5497.45025497449, 5498.917516237259, 5500.669959802424, 5209.7134657593815, 5365.0, 5396.973015134939, 5427.810026649068, 5454.59090568207, 5391.919121213185, 5396.514313711785, 5396.78412863485, 5402.35171779387, 5403.540699040586, 5392.973035134799, 5395.0558652235895, 5397.541208997221, 5435.864103397407, 5678.034734095172, 5200.219967004941, 5203.323567936182, 5204.193350030751, 5205.583553315726, 5206.0368831766245, 15101.093934363864, 15180.240987950558, 15186.0, 15214.923925380413, 22421.66367504489, 2372.1934542255717, 2410.963835542468, 2413.879306034709, 2440.3777036855668, 2803.2711495011445, 10842.403667798268, 10991.120710343153, 11163.386013769239, 11553.53785848565, 14476.638084047878, 1994.7406837111228, 2027.2093883385492, 2027.4627223785708, 2063.587282543497, 2096.465401322668, 62950.37049629491, 66611.66694166546, 67876.66021889236, 77262.61368693177, 80282.59858700786, 10929.508172132273, 11279.943600281946, 11622.0, 11892.583759568373, 11914.285142891282, 17315.0, 17333.913330433268, 17343.046132462583, 17348.566285842953, 17355.04547249888, 8672.523011234316, 8696.304295656333, 8807.647694092293, 8873.467591944504, 8908.465492070496, 7851.60741962911, 7883.2905038546805, 8017.278444939867, 8042.718504852302, 8084.7574572762915, 5088.491150884956, 5143.228515722672, 5207.635465517377, 5218.6868787872845, 5257.0, 2009.1862795567818, 2041.3875837248765, 2059.4668557674145, 2066.055870384696, 2097.9370618881458, 903.5346796399859, 965.7295957132014, 1034.8913364096811, 1052.936823790575, 1111.4109521953378, 18818.15318310679, 19983.300584479475, 20294.0, 20387.796122038886, 20399.796002040086, 994.2990191914682, 1012.2104758288547, 1029.8300780371305, 1043.8329867221207, 1076.7200527862656, 10466.842997355046, 10996.12031037515, 11119.555217791198, 11163.218574699855, 11172.441377931233, 464654.4805618867, 468055.0, 469907.0, 474324.0, 475816.0, 62151.378486215464, 88019.55990220008, 95508.52245738727, 96302.42880654303, 97508.02491974989, 994.4938754339025, 1037.8391349340864, 1041.7447725307347, 1043.3009883378154, 1050.7740835720356, 17710.203040862936, 18092.185851636972, 18198.5450363742, 18298.359557415428, 18370.81629183691, 39663.80168099141, 42469.1506169881, 43226.78386608047, 43753.56246437495, 44100.0, 55303.17045244244, 55518.16722749081, 60037.0, 60375.0, 60391.69804150951, 7444.851102977802, 7960.283574478325, 8047.195280471906, 8393.034800997719, 8572.142785721378, 11892.286462812259, 13318.533851315158, 13330.133541319783, 13497.662558436117, 13575.592732217654, 10991.725206869893, 11592.768144637228, 11832.585859494877, 11842.585509507126, 11916.344601047025, 5615.354234263112, 11128.332300062022, 11182.776344473228, 11506.712332191762, 11576.24754390962, 11465.828012579985, 11505.769884602094, 11676.591319304123, 11862.762744745229, 12020.75958480843, 7792.4545281832, 7950.761477155695, 8055.1944805521325, 8061.0326760789085, 8206.876896846672, 11114.44427778624, 11173.441327933408, 11315.151363647594, 11315.886841131483, 11813.940930295294], "value": 9182.739442681213, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1251.3242848861614, 1507.766296224085, 1514.5380658899035, 1660.3275673352289, 1801.0904493230917, 7610.1628820829665, 8132.471389359687, 8458.703945361905, 8476.618552165151, 8478.321734261259, 8341.749747507585, 8482.57587120643, 8493.065762766091, 8651.480911145336, 8652.783680407993, 2428.708554973401, 2472.7032756069298, 2473.9752602474014, 2481.1068015514493, 2481.1936120760734, 2429.125514814665, 2495.214007587604, 2519.3575638212324, 2519.5590771614984, 2529.380301826046, 2444.963325550118, 2471.270975062361, 2498.5502609530276, 2499.125306142854, 2502.2243104637528, 2328.9184878529254, 2358.6344116661858, 2385.594448943684, 2415.4444477770035, 2419.395151212197, 2342.8008619267384, 2360.7521210273017, 2382.583047966616, 2383.809295256375, 2384.5350156719446, 8514.403991720583, 8555.914440855575, 8589.184027517376, 8653.956730216372, 8657.870131948026, 5371.704556249405, 5512.310961129859, 5525.143602741541, 5597.244372009767, 5597.692126933017, 3431.673990970854, 3467.3474791784306, 3536.0806190390686, 3545.2023294758733, 3721.4417837324618, 1140.823172408278, 1153.2158132469917, 1161.384466232898, 1168.452772954958, 1178.723000094977, 11830.704232394173, 11996.520139194421, 12047.698807529881, 12048.096392770578, 12058.276503409736, 4775.450823155382, 4904.6321525885705, 4981.90036199274, 4986.152354099811, 5000.224965130411, 10307.587696492206, 10311.0, 10312.896871031344, 10317.793644127225, 10328.586856525804, 5570.997220500349, 5572.5263352614675, 5572.832815015556, 5573.136163894603, 5575.0522411190195, 4280.400743895857, 4453.844115456009, 4596.080783843245, 4988.27669987857, 5132.640715149903, 4251.744895306291, 4253.21315556623, 4315.525292217916, 4333.783310834446, 4369.148016136886, 1412.4562043613282, 1446.428660679047, 1450.514077783933, 1454.6945141520187, 1469.5297504798361, 898.9235914947172, 999.3104757717297, 1003.9799204015878, 1011.367895065584, 1015.4922538730634, 5743.483086522233, 5768.682722450221, 5877.882442351129, 5918.201042859159, 5988.9101663475085, 467.49744025172396, 473.3562355196929, 473.4295174314942, 477.4294717812181, 481.79523702426326, 4133.627973482401, 4163.375493675912, 4212.620864122244, 4223.873283801491, 4227.2179646764835, 10525.947405259412, 10797.676069717922, 10809.83785243222, 10927.726806829734, 10950.616728414467, 10035.648752293635, 10507.369557826554, 10823.56705731762, 10843.186760992958, 10856.620018299322, 8089.352851771844, 8269.338452923752, 8273.586320683942, 8277.337812974947, 8282.378821588405, 5682.857928551819, 5703.315602127771, 5807.419258074159, 5893.292804863272, 5911.881762364815, 9857.238956573563, 9922.156616687662, 10000.549975250986, 10005.299629025898, 10012.299139060196, 9073.59168837417, 9352.953235233781, 10214.642487512901, 10297.485125743833, 10388.896111038794, 7485.1017877855, 7697.307242348215, 7737.767866963775, 7902.762917112495, 7923.564203968606, 8525.74422767318, 8628.52543110135, 8683.913160868311, 8692.130786921258, 8692.304615630861, 7695.307422332017, 7791.805204869924, 7803.609819508888, 7830.256125668053, 7866.174051724486, 7542.132654744774, 7689.307962283421, 7707.0, 7733.149353570991, 7889.802754930943, 6910.20532638753, 6955.130608673916, 6963.373296403348, 7002.0, 7041.295870413122, 5327.653702509325, 5421.593380496557, 5454.890902182014, 5495.5878309127775, 5535.8892822142525, 5033.924491132562, 5046.77289521965, 5064.949350506447, 5078.263651770547, 5082.288479612931], "value": 4624.201802096556, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.9330423871584, 364.34054361605496, 368.2469350178883, 374.76951674720056, 375.6619042861426, 5172.6379153459275, 5302.708351040691, 5335.653182543132, 5356.812511562096, 5360.571154307656, 5022.748862556876, 5124.333836601246, 5157.5358217760395, 5160.174372100465, 5170.482951704827, 4158.941324044595, 4161.459010328653, 4167.499900011988, 4207.579242075799, 4225.598568136023, 4033.334499807528, 4189.539150693421, 4223.21870453967, 4230.428892099573, 4238.978805105986, 4135.338345864662, 4139.56534563871, 4163.770992595406, 4166.562510936354, 4188.392683060954, 4143.958560414402, 4158.37624356346, 4161.9803148228875, 4172.436721042681, 4179.185058913513, 3472.8263586820813, 3566.6076731559765, 3585.713142948558, 3594.238822976749, 3719.0, 5091.632390938232, 5097.929434818692, 5104.795808167669, 5117.257997590328, 5118.744062796883, 4631.212693842055, 4644.326572646981, 4657.720536767804, 4667.226453947478, 4667.649926255544, 5388.0, 5389.191621256804, 5424.403315635277, 5432.891342173174, 5501.982133305311, 3930.4693866328253, 3933.7639741615594, 3954.940675889864, 3956.4263181838473, 3978.1645854370618, 5712.857178570527, 5714.257146570961, 5776.364599894008, 5779.595428320062, 5783.5951483396175, 3957.22834047358, 4096.262672718939, 4120.381942708617, 4192.580741925783, 4209.642180414638, 4179.644730197967, 4212.283911735012, 4212.53662097169, 4214.777714462772, 4226.915461690749, 4739.786709598076, 4740.691855029481, 4741.241401375763, 4779.378680771547, 4804.471508134103, 5305.867353316198, 5467.726613669301, 5529.612927095065, 5532.589189756586, 5553.888922221533, 1330.401319406271, 1340.1690951610065, 1377.8966577506726, 1403.3123769353147, 1413.250976982201, 946.2571881073325, 948.1558368972283, 954.0364232125464, 969.60730903984, 975.9707208783748, 5155.510226528474, 5166.53841925903, 5168.560672342818, 5176.534111929869, 5183.3261675981885, 5291.497307755757, 5327.174287985368, 5341.732913354394, 5366.275552800322, 5380.435054319319, 4930.7288099154175, 5109.284700141983, 5120.257562653394, 5121.539061484485, 5134.358205224347, 2826.265171055499, 2842.4173044525824, 2845.146456063173, 2850.7884149236493, 2863.7136286371197, 5553.305836770403, 5590.385057643656, 5614.326280846324, 5623.634463759842, 5626.877083218853, 5341.839744807662, 5491.835244942658, 5501.0, 5504.559635229172, 5545.445455454423, 5547.694876781816, 5552.91670624941, 5561.805336813192, 5603.859903502445, 5616.157576363578, 5149.536541711264, 5323.1749078892835, 5345.518903298566, 5397.0, 5461.508464238238, 5289.7355132244, 5296.867578310573, 5314.601404894571, 5316.521513063843, 5319.574434045189, 5577.693226872561, 5589.692566908859, 5599.748011339581, 5613.494785469327, 5671.432856714296, 3907.452956586137, 3941.083598137415, 3978.482797236341, 3989.606236258222, 4023.3562629979065, 5339.225812257278, 5355.866103347447, 5358.892822143614, 5376.0, 5391.649542779707, 5378.811741589182, 5439.156930675752, 5490.396056433869, 5534.806281780279, 5551.666899986014, 5469.288992430958, 5483.4516548344845, 5498.862528436821, 5520.447955204448, 5531.502164805187, 5247.737613119252, 5427.375851777097, 5452.836414907559, 5472.91790623149, 5480.26016487785, 5500.477454641803, 5500.559955203494, 5517.36550296705, 5531.197976293334, 5534.4742249486235, 5437.972810135924, 5439.5648348132845, 5440.020796256712, 5458.781648734006, 5473.28847249855], "value": 4172.757712226798, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.070757920812, 818.897637795276, 835.9038710548286, 854.8845905802717, 894.2577660541751, 14647.780283295759, 15721.685566288668, 15860.762088568652, 15864.841351586481, 15930.283137258823, 14260.215688137148, 14297.356618952146, 14530.782038269408, 14569.417223311055, 14707.19110448925, 721.7221369772649, 848.4612271207766, 855.7347222361088, 856.4433118473012, 858.1547176031604, 722.7867779005206, 730.9378702810268, 731.3198725185575, 823.6499487717726, 849.0, 901.6123067081153, 903.4127816919022, 906.3972458315212, 908.1690253418114, 908.2189317187214, 900.8918929728442, 903.1375036839802, 903.814717982812, 904.3036861616519, 905.0, 549.1104410854401, 560.2548610348227, 632.9050642403677, 663.6714826161033, 664.8869692152346, 13943.511977080854, 14756.335964881499, 14775.70448591022, 14800.333984970595, 14810.259487025605, 14567.49013784523, 14823.851761482463, 14983.32575034126, 15007.249637518189, 15063.698726025528, 13366.866331336756, 13402.664933376645, 13414.664633384145, 13545.255010974393, 14161.150330980174, 3826.712996525244, 3938.330483817729, 4422.29243321067, 4461.687681862271, 4552.430946131733, 65184.3481565183, 65886.67056664734, 66040.0, 66267.66866165686, 67892.3210767891, 11250.774984500264, 11256.205267250223, 11309.434528273554, 11405.771884562262, 11437.428128593538, 18989.715154272697, 19087.61824763497, 19156.329528466715, 19800.90099549493, 19841.0, 7526.5107767994905, 7652.502587331805, 8126.471779334324, 8249.257566819015, 8437.3599003736, 4632.420947381577, 4706.858794236178, 4810.182269014206, 4881.048195601895, 4920.991196804646, 3334.983325083359, 3404.2170300830453, 3427.143214196451, 3441.7590768645955, 3505.631908649555, 628.6196850905136, 639.1020616034479, 641.9967900160469, 646.747768370336, 655.4297760948006, 741.7144399406268, 743.7694314762441, 775.4223103787714, 797.8125140591957, 802.5465611929242, 9550.283728720235, 10182.694519164437, 10270.794584108276, 10577.31247468912, 10651.360918344924, 697.0346070692128, 711.7971378157304, 719.7948584653349, 782.8590853646398, 816.3510009542309, 4779.5220477951925, 4954.207326827763, 4969.18008528596, 4973.975130124399, 4997.825076122318, 89457.55271223732, 90960.0, 93799.0, 94027.21698818576, 95851.52074239583, 60766.08850867241, 79675.60162199152, 80507.0, 81681.18318816736, 83870.58064709637, 74575.62712186405, 75396.62301688566, 75719.24280757231, 76486.61756691181, 78097.60951195208, 9198.2181514572, 9248.260139188715, 9408.43549387039, 9450.574724137568, 9582.377145485521, 49044.50955490399, 50090.99818003692, 50452.49547504478, 51051.9579216842, 52388.47611523836, 66251.33748662645, 68125.0, 68683.28291792746, 69488.0, 71706.64146679234, 11606.24559403636, 11849.52601895949, 11993.160478766402, 12128.0, 12409.503619855104, 13047.869521305045, 13657.795133072814, 13665.453381864614, 13883.861161388257, 13892.791608125684, 12913.0, 13204.669883252996, 13321.0, 13398.799018014543, 13623.0, 12125.211861228992, 12711.110222284722, 12745.936270318589, 12848.614541563767, 13177.209367437985, 11945.283283003047, 12564.748705025666, 13405.530806421728, 13443.126196797177, 13560.59318220455, 10604.946975265382, 10874.619388321687, 11058.557657693602, 11065.557377705123, 11385.544578216779, 10706.304090234109, 10892.128629709447, 11115.166362523005, 11220.270682405617, 11294.378809165575], "value": 7417.989454585811, "unit": "score"}], "name": "dromaeo_css", "value": 7279.090614760982, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 112.0, 112.0, 111.0, 111.0, 112.0, 111.0, 113.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 119.0, 124.0, 161.0, 122.0, 120.0, 128.0, 119.0, 152.0, 119.0], "value": 131.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 160.0, 160.0, 160.0, 161.0, 160.0, 161.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 105.0, 75.0, 76.0, 76.0, 74.0, 99.0, 76.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 119.0, 82.0, 82.0, 82.0, 98.0, 82.0, 82.0, 117.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 145.0, 147.0, 145.0, 146.0, 153.0, 146.0, 145.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 51.0, 49.0, 49.0, 49.0, 51.0, 49.0, 49.0, 51.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 61.0, 59.0, 59.0, 60.0, 59.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 75.0, 74.0, 75.0, 75.0, 76.0, 77.0, 83.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 141.0, 128.0, 135.0, 126.0, 138.0, 125.0, 126.0, 174.0, 126.0], "value": 134.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 158.0, 154.0, 155.0, 156.0, 156.0, 157.0, 157.0, 153.0, 156.0], "value": 155.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 60.0, 64.0, 65.0, 64.0, 60.0, 62.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1461.8, "alertThreshold": 2.0}]} 10:09:13 INFO - Return code: 0 10:09:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:09:13 ERROR - # TBPL SUCCESS # 10:09:13 INFO - Running post-action listener: _resource_record_post_action 10:09:13 INFO - [mozharness: 2016-11-14 18:09:13.300757Z] Finished run-tests step (success) 10:09:13 INFO - Running post-run listener: _resource_record_post_run 10:09:13 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 361951232; Read time: 152; Write time: 229260 10:09:13 INFO - TinderboxPrint: CPU usage
13.0% 10:09:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 152 10:09:13 INFO - TinderboxPrint: I/O write bytes / time
361,951,232 / 229,260 10:09:13 INFO - TinderboxPrint: CPU idle
8,275.7 (87.0%) 10:09:13 INFO - TinderboxPrint: CPU user
1,192.0 (12.5%) 10:09:13 INFO - TinderboxPrint: Swap in / out
0 / 0 10:09:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115961856; Read time: 0; Write time: 91428 10:09:13 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 245989376; Read time: 152; Write time: 137832 10:09:13 INFO - Running post-run listener: _upload_blobber_files 10:09:13 INFO - Blob upload gear active. 10:09:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:09:13 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 10:09:13 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:09:13 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:09:14 INFO - (blobuploader) - INFO - Open directory for files ... 10:09:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:09:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:09:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:18 INFO - (blobuploader) - INFO - Done attempting. 10:09:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:09:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:09:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:19 INFO - (blobuploader) - INFO - Done attempting. 10:09:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:09:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:09:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:19 INFO - (blobuploader) - INFO - Done attempting. 10:09:19 INFO - (blobuploader) - INFO - Iteration through files over. 10:09:19 INFO - Return code: 0 10:09:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:09:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:09:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07b53a1e8c6afa8e4011792847d0c4d252de9c5d51cbb682db870e5d74997f1ce88bbd74627c50595a4a86bd39f487b553f22f0b6e6f6cd50fead842856bac91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2f592c937c5e54993343483bd289e48018004b00b7c0445c426f2e0f71361cfc0dd452c512e8e0054d24e727637cc6ab82598d50b61c6f0f4a6f9a2826e63c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d3a72a0b9bea4adb5c9122df36a47ba807a00f8cd157ac1949edc53da1a6e4142f809c7e4eed7a72ecf4d9de33a5abb5d8b990b0c7e5da4c6782c6e8d51bd23"} 10:09:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:09:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:09:19 INFO - Contents: 10:09:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07b53a1e8c6afa8e4011792847d0c4d252de9c5d51cbb682db870e5d74997f1ce88bbd74627c50595a4a86bd39f487b553f22f0b6e6f6cd50fead842856bac91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2f592c937c5e54993343483bd289e48018004b00b7c0445c426f2e0f71361cfc0dd452c512e8e0054d24e727637cc6ab82598d50b61c6f0f4a6f9a2826e63c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d3a72a0b9bea4adb5c9122df36a47ba807a00f8cd157ac1949edc53da1a6e4142f809c7e4eed7a72ecf4d9de33a5abb5d8b990b0c7e5da4c6782c6e8d51bd23"} 10:09:19 INFO - Running post-run listener: copy_logs_to_upload_dir 10:09:19 INFO - Copying logs to upload dir... 10:09:19 INFO - mkdir: /builds/slave/test/build/upload/logs 10:09:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.673248 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-14 10:09:17.932280) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 10:09:17.935514) ========= 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=d2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07b53a1e8c6afa8e4011792847d0c4d252de9c5d51cbb682db870e5d74997f1ce88bbd74627c50595a4a86bd39f487b553f22f0b6e6f6cd50fead842856bac91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2f592c937c5e54993343483bd289e48018004b00b7c0445c426f2e0f71361cfc0dd452c512e8e0054d24e727637cc6ab82598d50b61c6f0f4a6f9a2826e63c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d3a72a0b9bea4adb5c9122df36a47ba807a00f8cd157ac1949edc53da1a6e4142f809c7e4eed7a72ecf4d9de33a5abb5d8b990b0c7e5da4c6782c6e8d51bd23"} build_url:https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011687 build_url: 'https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07b53a1e8c6afa8e4011792847d0c4d252de9c5d51cbb682db870e5d74997f1ce88bbd74627c50595a4a86bd39f487b553f22f0b6e6f6cd50fead842856bac91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2f592c937c5e54993343483bd289e48018004b00b7c0445c426f2e0f71361cfc0dd452c512e8e0054d24e727637cc6ab82598d50b61c6f0f4a6f9a2826e63c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d3a72a0b9bea4adb5c9122df36a47ba807a00f8cd157ac1949edc53da1a6e4142f809c7e4eed7a72ecf4d9de33a5abb5d8b990b0c7e5da4c6782c6e8d51bd23"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 10:09:17.960867) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:09:17.964246) ========= 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=d2a8c569965ab8367867b893000001a1-1479145720.569316-1914689601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:09:18.044050) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 10:09:18.047521) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 10:09:18.047865) ========= ========= Total master_lag: 0.18 =========