builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1484476622.16 results: success (0) buildid: 20170115004008 builduid: 8a7bdb42dba84eb3afaaa0c1ef3c7fce revision: 1e04cc4582dd86864035f0aed5fac81907dea848 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-15 02:37:02.159510) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-15 02:37:02.159960) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-15 02:37:02.160294) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-15 02:37:02.210481) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 02:37:02.210811) ========= 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=1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-15 02:37:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 205M=0s 2017-01-15 02:37:02 (205 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124505 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 02:37:02.354606) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 02:37:02.354970) ========= 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=1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014480 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 02:37:02.406825) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 02:37:02.407478) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1e04cc4582dd86864035f0aed5fac81907dea848 --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 1e04cc4582dd86864035f0aed5fac81907dea848 --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=1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-15 02:37:02,571 truncating revision to first 12 chars 2017-01-15 02:37:02,571 Setting DEBUG logging. 2017-01-15 02:37:02,571 attempt 1/10 2017-01-15 02:37:02,571 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1e04cc4582dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-15 02:37:03,203 unpacking tar archive at: mozilla-aurora-1e04cc4582dd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.971905 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 02:37:03.398233) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-15 02:37:03.398893) ========= script_repo_revision: 1e04cc4582dd86864035f0aed5fac81907dea848 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-15 02:37:03.399368) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-15 02:37:03.399682) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-15 02:37:03.413332) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-01-15 02:37:03.413627) ========= /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=1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:37:03 INFO - MultiFileLogger online at 20170115 02:37:03 in /builds/slave/test 02:37:03 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 02:37:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:37:03 INFO - {'append_to_log': False, 02:37:03 INFO - 'base_work_dir': '/builds/slave/test', 02:37:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:37:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:37:03 INFO - 'branch': 'Mozilla-Aurora', 02:37:03 INFO - 'buildbot_json_path': 'buildprops.json', 02:37:03 INFO - 'config_files': ('talos/linux_config.py',), 02:37:03 INFO - 'default_actions': ('clobber', 02:37:03 INFO - 'read-buildbot-config', 02:37:03 INFO - 'download-and-extract', 02:37:03 INFO - 'populate-webroot', 02:37:03 INFO - 'create-virtualenv', 02:37:03 INFO - 'install', 02:37:03 INFO - 'run-tests'), 02:37:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:37:03 INFO - 'download_minidump_stackwalk': True, 02:37:03 INFO - 'download_symbols': 'ondemand', 02:37:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:37:03 INFO - 'tooltool.py': '/tools/tooltool.py', 02:37:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:37:03 INFO - '/tools/misc-python/virtualenv.py')}, 02:37:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:37:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:37:03 INFO - 'installer_path': 'installer.exe', 02:37:03 INFO - 'log_level': 'info', 02:37:03 INFO - 'log_name': 'talos', 02:37:03 INFO - 'log_to_console': True, 02:37:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:37:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:37:03 INFO - 'opt_config_files': (), 02:37:03 INFO - 'pip_index': False, 02:37:03 INFO - 'sps_profile': False, 02:37:03 INFO - 'sps_profile_interval': 0, 02:37:03 INFO - 'suite': 'dromaeojs', 02:37:03 INFO - 'system_bits': '32', 02:37:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:37:03 INFO - 'title': 'talos-linux64-ix-027', 02:37:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:37:03 INFO - 'use_talos_json': True, 02:37:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:37:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:37:03 INFO - 'work_dir': 'build'} 02:37:03 INFO - [mozharness: 2017-01-15 10:37:03.763648Z] Running clobber step. 02:37:03 INFO - Running pre-action listener: _resource_record_pre_action 02:37:03 INFO - Running main action method: clobber 02:37:03 INFO - rmtree: /builds/slave/test/build 02:37:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:37:04 INFO - Running post-action listener: _resource_record_post_action 02:37:04 INFO - [mozharness: 2017-01-15 10:37:04.173781Z] Finished clobber step (success) 02:37:04 INFO - [mozharness: 2017-01-15 10:37:04.173881Z] Running read-buildbot-config step. 02:37:04 INFO - Running pre-action listener: _resource_record_pre_action 02:37:04 INFO - Running main action method: read_buildbot_config 02:37:04 INFO - Using buildbot properties: 02:37:04 INFO - { 02:37:04 INFO - "project": "", 02:37:04 INFO - "product": "firefox", 02:37:04 INFO - "script_repo_revision": "production", 02:37:04 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:37:04 INFO - "repository": "", 02:37:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:37:04 INFO - "buildid": "20170115004008", 02:37:04 INFO - "stage_platform": "linux64-pgo", 02:37:04 INFO - "basedir": "/builds/slave/test", 02:37:04 INFO - "nightly_build": "True", 02:37:04 INFO - "buildnumber": 707, 02:37:04 INFO - "slavename": "talos-linux64-ix-027", 02:37:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:37:04 INFO - "platform": "ubuntu64_hw", 02:37:04 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:37:04 INFO - "branch": "mozilla-aurora", 02:37:04 INFO - "repo_path": "releases/mozilla-aurora", 02:37:04 INFO - "revision": "1e04cc4582dd86864035f0aed5fac81907dea848", 02:37:04 INFO - "pgo_build": "True", 02:37:04 INFO - "builduid": "8a7bdb42dba84eb3afaaa0c1ef3c7fce", 02:37:04 INFO - "slavebuilddir": "test" 02:37:04 INFO - } 02:37:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/cupKHqifQJ6KBYAhzVElNA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 02:37:04 INFO - Running post-action listener: _resource_record_post_action 02:37:04 INFO - [mozharness: 2017-01-15 10:37:04.176599Z] Finished read-buildbot-config step (success) 02:37:04 INFO - [mozharness: 2017-01-15 10:37:04.176686Z] Running download-and-extract step. 02:37:04 INFO - Running pre-action listener: _resource_record_pre_action 02:37:04 INFO - Running main action method: download_and_extract 02:37:04 INFO - mkdir: /builds/slave/test/build/tests 02:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:04 INFO - trying https://queue.taskcluster.net/v1/task/cupKHqifQJ6KBYAhzVElNA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:37:04 INFO - Downloading https://queue.taskcluster.net/v1/task/cupKHqifQJ6KBYAhzVElNA/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 02:37:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cupKHqifQJ6KBYAhzVElNA/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 02:37:04 INFO - Downloaded 1361 bytes. 02:37:04 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:37:04 INFO - Using the following test package requirements: 02:37:04 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:37:04 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:37:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:37:04 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:37:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:37:04 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:37:04 INFO - u'jsshell-linux-x86_64.zip'], 02:37:04 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:37:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:37:04 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:37:04 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:37:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:37:04 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:37:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:37:04 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:37:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:37:04 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:37:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:37:04 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:37:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cupKHqifQJ6KBYAhzVElNA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:37:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cupKHqifQJ6KBYAhzVElNA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:37:04 INFO - Fetch https://queue.taskcluster.net/v1/task/cupKHqifQJ6KBYAhzVElNA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:37:05 INFO - Http code: 200 02:37:05 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 02:37:05 INFO - x-amz-cf-id: iSQ2rxEwdTpnYlkwe8-C3djwvwM7hNGLdFkzK1ZeNnmCVmYuntSF_w== 02:37:05 INFO - x-amz-version-id: .n5r3L0YI2UaIjq4kggwUiKuoACXTeR7 02:37:05 INFO - Expected file size: 21948789 02:37:05 INFO - Obtained file size: 21948789 02:37:09 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 02:37:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cupKHqifQJ6KBYAhzVElNA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:37:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cupKHqifQJ6KBYAhzVElNA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:37:09 INFO - Fetch https://queue.taskcluster.net/v1/task/cupKHqifQJ6KBYAhzVElNA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:37:10 INFO - Http code: 200 02:37:10 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 02:37:10 INFO - x-amz-cf-id: A73b9vcm5a3Ts8pzC2m4fBTCY2A4_Shx1T7nhxKg9kcneRZ5knOG_Q== 02:37:10 INFO - x-amz-version-id: .n5r3L0YI2UaIjq4kggwUiKuoACXTeR7 02:37:10 INFO - Expected file size: 21948789 02:37:10 INFO - Obtained file size: 21948789 02:37:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cupKHqifQJ6KBYAhzVElNA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 02:37:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cupKHqifQJ6KBYAhzVElNA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:37:14 INFO - Fetch https://queue.taskcluster.net/v1/task/cupKHqifQJ6KBYAhzVElNA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 02:37:15 INFO - Http code: 200 02:37:15 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 02:37:15 INFO - x-amz-cf-id: PLxEAuNkpdynfPSCVmEC3DfxWYKz_OTAHX5inwfsVjRNkV66E-6RmA== 02:37:15 INFO - x-amz-version-id: eV6JFFvve_kav.LwU.rM3QPPNMu5zVmk 02:37:15 INFO - Expected file size: 14409038 02:37:15 INFO - Obtained file size: 14409038 02:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:15 INFO - trying https://queue.taskcluster.net/v1/task/cupKHqifQJ6KBYAhzVElNA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:37:15 INFO - Downloading https://queue.taskcluster.net/v1/task/cupKHqifQJ6KBYAhzVElNA/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 02:37:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cupKHqifQJ6KBYAhzVElNA/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 02:37:17 INFO - Downloaded 64127992 bytes. 02:37:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cupKHqifQJ6KBYAhzVElNA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:37:17 INFO - mkdir: /builds/slave/test/properties 02:37:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:37:17 INFO - Writing to file /builds/slave/test/properties/build_url 02:37:17 INFO - Contents: 02:37:17 INFO - build_url:https://queue.taskcluster.net/v1/task/cupKHqifQJ6KBYAhzVElNA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:37:17 INFO - Running post-action listener: _resource_record_post_action 02:37:17 INFO - Running post-action listener: set_extra_try_arguments 02:37:17 INFO - [mozharness: 2017-01-15 10:37:17.841841Z] Finished download-and-extract step (success) 02:37:17 INFO - [mozharness: 2017-01-15 10:37:17.842146Z] Running populate-webroot step. 02:37:17 INFO - Running pre-action listener: _resource_record_pre_action 02:37:17 INFO - Running main action method: populate_webroot 02:37:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:37:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:37:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:37:17 INFO - '--tppagecycles', 02:37:17 INFO - '7'], 02:37:17 INFO - 'tests': ['tsvgm']}}, 02:37:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:37:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:37:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:37:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:37:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:37:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:37:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:37:17 INFO - 'talos_options': ['--disable-e10s'], 02:37:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:37:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:37:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:37:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:37:17 INFO - 'talos_options': ['--disable-e10s'], 02:37:17 INFO - 'tests': ['damp', 'tps']}, 02:37:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:37:17 INFO - 'tests': ['damp', 'tps']}, 02:37:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:37:17 INFO - 'tests': ['dromaeo_dom']}, 02:37:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:37:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:37:17 INFO - 'tests': ['basic_compositor_video']}, 02:37:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:37:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:37:17 INFO - 'tests': ['a11yr', 02:37:17 INFO - 'ts_paint', 02:37:17 INFO - 'tpaint', 02:37:17 INFO - 'sessionrestore', 02:37:17 INFO - 'sessionrestore_no_auto_restore', 02:37:17 INFO - 'tabpaint']}, 02:37:17 INFO - 'other-e10s': {'tests': ['a11yr', 02:37:17 INFO - 'ts_paint', 02:37:17 INFO - 'tpaint', 02:37:17 INFO - 'sessionrestore', 02:37:17 INFO - 'sessionrestore_no_auto_restore', 02:37:17 INFO - 'tabpaint']}, 02:37:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:37:17 INFO - 'ts_paint', 02:37:17 INFO - 'tpaint', 02:37:17 INFO - 'sessionrestore', 02:37:17 INFO - 'sessionrestore_no_auto_restore', 02:37:17 INFO - 'tabpaint']}, 02:37:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:37:17 INFO - 'ts_paint', 02:37:17 INFO - 'tpaint', 02:37:17 INFO - 'sessionrestore', 02:37:17 INFO - 'sessionrestore_no_auto_restore', 02:37:17 INFO - 'tabpaint']}, 02:37:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:37:17 INFO - 'tests': ['a11yr', 02:37:17 INFO - 'ts_paint', 02:37:17 INFO - 'tpaint', 02:37:17 INFO - 'sessionrestore', 02:37:17 INFO - 'sessionrestore_no_auto_restore', 02:37:17 INFO - 'tabpaint']}, 02:37:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:37:17 INFO - 'tests': ['a11yr', 02:37:17 INFO - 'ts_paint', 02:37:17 INFO - 'tpaint', 02:37:17 INFO - 'sessionrestore', 02:37:17 INFO - 'sessionrestore_no_auto_restore', 02:37:17 INFO - 'tabpaint']}, 02:37:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:37:17 INFO - 'tests': ['tsvgx', 02:37:17 INFO - 'tsvgr_opacity', 02:37:17 INFO - 'tart', 02:37:17 INFO - 'tscrollx', 02:37:17 INFO - 'cart']}, 02:37:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:37:17 INFO - 'tsvgr_opacity', 02:37:17 INFO - 'tart', 02:37:17 INFO - 'tscrollx', 02:37:17 INFO - 'cart']}, 02:37:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:37:17 INFO - 'talos_options': ['--disable-e10s'], 02:37:17 INFO - 'tests': ['tp5o']}, 02:37:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:37:17 INFO - 'tests': ['tp5o']}, 02:37:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:37:17 INFO - 'talos_options': ['--disable-e10s', 02:37:17 INFO - '--xperf_path', 02:37:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:37:17 INFO - 'tests': ['tp5n']}, 02:37:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:37:17 INFO - 'talos_options': ['--xperf_path', 02:37:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:37:17 INFO - 'tests': ['tp5n']}}, 02:37:17 INFO - 'talos.zip': {'path': '', 02:37:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:37:17 INFO - Running post-action listener: _resource_record_post_action 02:37:17 INFO - [mozharness: 2017-01-15 10:37:17.861490Z] Finished populate-webroot step (success) 02:37:17 INFO - [mozharness: 2017-01-15 10:37:17.861584Z] Running create-virtualenv step. 02:37:17 INFO - Running pre-action listener: _resource_record_pre_action 02:37:17 INFO - Running main action method: create_virtualenv 02:37:17 INFO - Creating virtualenv /builds/slave/test/build/venv 02:37:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:37:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:37:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:37:18 INFO - Using real prefix '/usr' 02:37:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:37:18 INFO - Installing distribute.............................................................................................................................................................................................done. 02:37:20 INFO - Installing pip.................done. 02:37:20 INFO - Return code: 0 02:37:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:37:20 INFO - Reading from file tmpfile_stdout 02:37:20 INFO - Output received: 02:37:20 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:37:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:37: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')]} 02:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37: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')]} 02:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4970b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ffca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fcf60>, '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 0x21fdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21fe1d0>, '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': '1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:37: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', 'pip>=1.5'] in /builds/slave/test/build 02:37: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 pip>=1.5 02:37:20 INFO - Using env: {'DISPLAY': ':0', 02:37:20 INFO - 'HOME': '/home/cltbld', 02:37:20 INFO - 'LANG': 'en_US.UTF-8', 02:37:20 INFO - 'LANGUAGE': 'en_US:en', 02:37:20 INFO - 'LOGNAME': 'cltbld', 02:37:20 INFO - 'MAIL': '/var/mail/cltbld', 02:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:20 INFO - 'MOZ_NO_REMOTE': '1', 02:37:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:20 INFO - 'NO_EM_RESTART': '1', 02:37:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:20 INFO - 'PWD': '/builds/slave/test', 02:37:20 INFO - 'SHELL': '/bin/bash', 02:37:20 INFO - 'SHLVL': '1', 02:37:20 INFO - 'TERM': 'linux', 02:37:20 INFO - 'TMOUT': '86400', 02:37:20 INFO - 'USER': 'cltbld', 02:37:20 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632', 02:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:20 INFO - '_': '/tools/buildbot/bin/python'} 02:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:37:21 INFO - Cleaning up... 02:37:21 INFO - Return code: 0 02:37:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4970b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ffca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fcf60>, '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 0x21fdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21fe1d0>, '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': '1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:37:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:37:21 INFO - Using env: {'DISPLAY': ':0', 02:37:21 INFO - 'HOME': '/home/cltbld', 02:37:21 INFO - 'LANG': 'en_US.UTF-8', 02:37:21 INFO - 'LANGUAGE': 'en_US:en', 02:37:21 INFO - 'LOGNAME': 'cltbld', 02:37:21 INFO - 'MAIL': '/var/mail/cltbld', 02:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:21 INFO - 'MOZ_NO_REMOTE': '1', 02:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:21 INFO - 'NO_EM_RESTART': '1', 02:37:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:21 INFO - 'PWD': '/builds/slave/test', 02:37:21 INFO - 'SHELL': '/bin/bash', 02:37:21 INFO - 'SHLVL': '1', 02:37:21 INFO - 'TERM': 'linux', 02:37:21 INFO - 'TMOUT': '86400', 02:37:21 INFO - 'USER': 'cltbld', 02:37:21 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632', 02:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:21 INFO - '_': '/tools/buildbot/bin/python'} 02:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:21 INFO - Downloading/unpacking psutil>=3.1.1 02:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:37:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:37:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:37:23 INFO - Installing collected packages: psutil 02:37:23 INFO - Running setup.py install for psutil 02:37:23 INFO - building 'psutil._psutil_linux' extension 02:37:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:37:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:37:24 INFO - building 'psutil._psutil_posix' extension 02:37:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:37:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:37:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:37:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:37:24 INFO - Successfully installed psutil 02:37:24 INFO - Cleaning up... 02:37:24 INFO - Return code: 0 02:37:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:24 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 0x7f4970b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ffca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fcf60>, '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 0x21fdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21fe1d0>, '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': '1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:37:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:37:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:37:24 INFO - Using env: {'DISPLAY': ':0', 02:37:24 INFO - 'HOME': '/home/cltbld', 02:37:24 INFO - 'LANG': 'en_US.UTF-8', 02:37:24 INFO - 'LANGUAGE': 'en_US:en', 02:37:24 INFO - 'LOGNAME': 'cltbld', 02:37:24 INFO - 'MAIL': '/var/mail/cltbld', 02:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:24 INFO - 'MOZ_NO_REMOTE': '1', 02:37:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:24 INFO - 'NO_EM_RESTART': '1', 02:37:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:24 INFO - 'PWD': '/builds/slave/test', 02:37:24 INFO - 'SHELL': '/bin/bash', 02:37:24 INFO - 'SHLVL': '1', 02:37:24 INFO - 'TERM': 'linux', 02:37:24 INFO - 'TMOUT': '86400', 02:37:24 INFO - 'USER': 'cltbld', 02:37:24 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632', 02:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:24 INFO - '_': '/tools/buildbot/bin/python'} 02:37:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:37:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:37:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:37:27 INFO - Installing collected packages: mozsystemmonitor 02:37:27 INFO - Running setup.py install for mozsystemmonitor 02:37:27 INFO - Successfully installed mozsystemmonitor 02:37:27 INFO - Cleaning up... 02:37:27 INFO - Return code: 0 02:37:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:27 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 0x7f4970b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ffca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fcf60>, '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 0x21fdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21fe1d0>, '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': '1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:37:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:37:27 INFO - Using env: {'DISPLAY': ':0', 02:37:27 INFO - 'HOME': '/home/cltbld', 02:37:27 INFO - 'LANG': 'en_US.UTF-8', 02:37:27 INFO - 'LANGUAGE': 'en_US:en', 02:37:27 INFO - 'LOGNAME': 'cltbld', 02:37:27 INFO - 'MAIL': '/var/mail/cltbld', 02:37:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:27 INFO - 'MOZ_NO_REMOTE': '1', 02:37:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:27 INFO - 'NO_EM_RESTART': '1', 02:37:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:27 INFO - 'PWD': '/builds/slave/test', 02:37:27 INFO - 'SHELL': '/bin/bash', 02:37:27 INFO - 'SHLVL': '1', 02:37:27 INFO - 'TERM': 'linux', 02:37:27 INFO - 'TMOUT': '86400', 02:37:27 INFO - 'USER': 'cltbld', 02:37:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632', 02:37:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:27 INFO - '_': '/tools/buildbot/bin/python'} 02:37:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:27 INFO - Downloading/unpacking jsonschema==2.5.1 02:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:37:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:29 INFO - Downloading functools32-3.2.3-2.tar.gz 02:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:37:29 INFO - warning: no files found matching '*.txt' 02:37:29 INFO - no previously-included directories found matching 'build' 02:37:29 INFO - no previously-included directories found matching 'dist' 02:37:29 INFO - no previously-included directories found matching '.git*' 02:37:29 INFO - Installing collected packages: jsonschema, functools32 02:37:29 INFO - Running setup.py install for functools32 02:37:29 INFO - warning: no files found matching '*.txt' 02:37:29 INFO - no previously-included directories found matching 'build' 02:37:29 INFO - no previously-included directories found matching 'dist' 02:37:29 INFO - no previously-included directories found matching '.git*' 02:37:29 INFO - Successfully installed jsonschema functools32 02:37:29 INFO - Cleaning up... 02:37:29 INFO - Return code: 0 02:37:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:29 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 0x7f4970b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ffca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fcf60>, '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 0x21fdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21fe1d0>, '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': '1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:37:29 INFO - Using env: {'DISPLAY': ':0', 02:37:29 INFO - 'HOME': '/home/cltbld', 02:37:29 INFO - 'LANG': 'en_US.UTF-8', 02:37:29 INFO - 'LANGUAGE': 'en_US:en', 02:37:29 INFO - 'LOGNAME': 'cltbld', 02:37:29 INFO - 'MAIL': '/var/mail/cltbld', 02:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:29 INFO - 'MOZ_NO_REMOTE': '1', 02:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:29 INFO - 'NO_EM_RESTART': '1', 02:37:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:29 INFO - 'PWD': '/builds/slave/test', 02:37:29 INFO - 'SHELL': '/bin/bash', 02:37:29 INFO - 'SHLVL': '1', 02:37:29 INFO - 'TERM': 'linux', 02:37:29 INFO - 'TMOUT': '86400', 02:37:29 INFO - 'USER': 'cltbld', 02:37:29 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632', 02:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:29 INFO - '_': '/tools/buildbot/bin/python'} 02:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:37:30 INFO - Cleaning up... 02:37:30 INFO - Return code: 0 02:37:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:37:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:30 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 0x7f4970b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ffca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fcf60>, '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 0x21fdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21fe1d0>, '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': '1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:37:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:37:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:37:30 INFO - Using env: {'DISPLAY': ':0', 02:37:30 INFO - 'HOME': '/home/cltbld', 02:37:30 INFO - 'LANG': 'en_US.UTF-8', 02:37:30 INFO - 'LANGUAGE': 'en_US:en', 02:37:30 INFO - 'LOGNAME': 'cltbld', 02:37:30 INFO - 'MAIL': '/var/mail/cltbld', 02:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:30 INFO - 'MOZ_NO_REMOTE': '1', 02:37:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:30 INFO - 'NO_EM_RESTART': '1', 02:37:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:30 INFO - 'PWD': '/builds/slave/test', 02:37:30 INFO - 'SHELL': '/bin/bash', 02:37:30 INFO - 'SHLVL': '1', 02:37:30 INFO - 'TERM': 'linux', 02:37:30 INFO - 'TMOUT': '86400', 02:37:30 INFO - 'USER': 'cltbld', 02:37:30 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632', 02:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:30 INFO - '_': '/tools/buildbot/bin/python'} 02:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:30 INFO - Downloading/unpacking blobuploader==1.2.4 02:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:32 INFO - Downloading blobuploader-1.2.4.tar.gz 02:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:37:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:37:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:33 INFO - Downloading docopt-0.6.1.tar.gz 02:37:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:37:33 INFO - Installing collected packages: blobuploader, requests, docopt 02:37:33 INFO - Running setup.py install for blobuploader 02:37:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:37:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:37:33 INFO - Running setup.py install for requests 02:37:33 INFO - Running setup.py install for docopt 02:37:33 INFO - Successfully installed blobuploader requests docopt 02:37:33 INFO - Cleaning up... 02:37:33 INFO - Return code: 0 02:37:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:33 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 0x7f4970b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ffca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fcf60>, '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 0x21fdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21fe1d0>, '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': '1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:37:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:37:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:37:33 INFO - Using env: {'DISPLAY': ':0', 02:37:33 INFO - 'HOME': '/home/cltbld', 02:37:33 INFO - 'LANG': 'en_US.UTF-8', 02:37:33 INFO - 'LANGUAGE': 'en_US:en', 02:37:33 INFO - 'LOGNAME': 'cltbld', 02:37:33 INFO - 'MAIL': '/var/mail/cltbld', 02:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:33 INFO - 'MOZ_NO_REMOTE': '1', 02:37:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:33 INFO - 'NO_EM_RESTART': '1', 02:37:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:33 INFO - 'PWD': '/builds/slave/test', 02:37:33 INFO - 'SHELL': '/bin/bash', 02:37:33 INFO - 'SHLVL': '1', 02:37:33 INFO - 'TERM': 'linux', 02:37:33 INFO - 'TMOUT': '86400', 02:37:33 INFO - 'USER': 'cltbld', 02:37:33 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632', 02:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:33 INFO - '_': '/tools/buildbot/bin/python'} 02:37:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:37:34 INFO - Running setup.py (path:/tmp/pip-1NeN6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:37:34 INFO - Running setup.py (path:/tmp/pip-vH6nXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:37:34 INFO - Running setup.py (path:/tmp/pip-8w2cPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:37:34 INFO - Running setup.py (path:/tmp/pip-vWWW7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:37:34 INFO - Running setup.py (path:/tmp/pip-_pW0DU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:37:34 INFO - Running setup.py (path:/tmp/pip-8U9I5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:37:34 INFO - Running setup.py (path:/tmp/pip-mVbxlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:37:34 INFO - Running setup.py (path:/tmp/pip-dzVdMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:37:34 INFO - Running setup.py (path:/tmp/pip-Ug1QpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:37:34 INFO - Running setup.py (path:/tmp/pip-NGpXg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:37:34 INFO - Running setup.py (path:/tmp/pip-gULVFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:37:34 INFO - Running setup.py (path:/tmp/pip-e6pX5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:37:34 INFO - Running setup.py (path:/tmp/pip-iV0Gif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:37:34 INFO - Running setup.py (path:/tmp/pip-6ccsdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:37:35 INFO - Running setup.py (path:/tmp/pip-Qejfz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:37:35 INFO - Running setup.py (path:/tmp/pip-DZ2_ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:37:35 INFO - Running setup.py (path:/tmp/pip-LH1V8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:37:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:37:35 INFO - Running setup.py install for manifestparser 02:37:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:37:35 INFO - Running setup.py install for mozcrash 02:37:35 INFO - Running setup.py install for mozdebug 02:37:35 INFO - Running setup.py install for mozdevice 02:37:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:37:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:37:35 INFO - Running setup.py install for mozfile 02:37:35 INFO - Running setup.py install for mozhttpd 02:37:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:37:35 INFO - Running setup.py install for mozinfo 02:37:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:37:35 INFO - Running setup.py install for mozInstall 02:37:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:37:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:37:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:37:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:37:36 INFO - Running setup.py install for mozleak 02:37:36 INFO - Running setup.py install for mozlog 02:37:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:37:36 INFO - Running setup.py install for moznetwork 02:37:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:37:36 INFO - Running setup.py install for mozprocess 02:37:36 INFO - Running setup.py install for mozprofile 02:37:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:37:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:37:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:37:36 INFO - Running setup.py install for mozrunner 02:37:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:37:36 INFO - Running setup.py install for mozscreenshot 02:37:36 INFO - Running setup.py install for moztest 02:37:36 INFO - Running setup.py install for mozversion 02:37:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:37:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:37:37 INFO - Cleaning up... 02:37:37 INFO - Return code: 0 02:37:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:37 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 0x7f4970b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ffca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fcf60>, '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 0x21fdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21fe1d0>, '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': '1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:37:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:37:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:37:37 INFO - Using env: {'DISPLAY': ':0', 02:37:37 INFO - 'HOME': '/home/cltbld', 02:37:37 INFO - 'LANG': 'en_US.UTF-8', 02:37:37 INFO - 'LANGUAGE': 'en_US:en', 02:37:37 INFO - 'LOGNAME': 'cltbld', 02:37:37 INFO - 'MAIL': '/var/mail/cltbld', 02:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:37 INFO - 'MOZ_NO_REMOTE': '1', 02:37:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:37 INFO - 'NO_EM_RESTART': '1', 02:37:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:37 INFO - 'PWD': '/builds/slave/test', 02:37:37 INFO - 'SHELL': '/bin/bash', 02:37:37 INFO - 'SHLVL': '1', 02:37:37 INFO - 'TERM': 'linux', 02:37:37 INFO - 'TMOUT': '86400', 02:37:37 INFO - 'USER': 'cltbld', 02:37:37 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632', 02:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:37 INFO - '_': '/tools/buildbot/bin/python'} 02:37:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:37:37 INFO - Running setup.py (path:/tmp/pip-TeMGTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:37:37 INFO - Running setup.py (path:/tmp/pip-uopwvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:37:37 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)) 02:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:37:37 INFO - Running setup.py (path:/tmp/pip-51Kg7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:37:37 INFO - Running setup.py (path:/tmp/pip-9UEiXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:37:37 INFO - Running setup.py (path:/tmp/pip-FwJjuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:37:37 INFO - Running setup.py (path:/tmp/pip-3G1xQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:37:37 INFO - Running setup.py (path:/tmp/pip-a4Ffz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:37:37 INFO - Running setup.py (path:/tmp/pip-B94dgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:37:37 INFO - Running setup.py (path:/tmp/pip-rgwrF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:37:37 INFO - Running setup.py (path:/tmp/pip-OWhvYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:37:38 INFO - Running setup.py (path:/tmp/pip-7_DXSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:37:38 INFO - Running setup.py (path:/tmp/pip-enaCuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:37:38 INFO - Running setup.py (path:/tmp/pip-JrWmCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:37:38 INFO - Running setup.py (path:/tmp/pip-dihFpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:37:38 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)) 02:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:37:38 INFO - Running setup.py (path:/tmp/pip-VOAWcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:37:38 INFO - Running setup.py (path:/tmp/pip-yMmpVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:37:38 INFO - Running setup.py (path:/tmp/pip-IxqVYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:37:38 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)) 02:37:38 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)) 02:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:37:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:40 INFO - Downloading blessings-1.6.tar.gz 02:37:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:37:40 INFO - Installing collected packages: blessings 02:37:40 INFO - Running setup.py install for blessings 02:37:40 INFO - Successfully installed blessings 02:37:40 INFO - Cleaning up... 02:37:40 INFO - Return code: 0 02:37:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:37:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:37:41 INFO - Reading from file tmpfile_stdout 02:37:41 INFO - Current package versions: 02:37:41 INFO - argparse == 1.2.1 02:37:41 INFO - blessings == 1.6 02:37:41 INFO - blobuploader == 1.2.4 02:37:41 INFO - docopt == 0.6.1 02:37:41 INFO - functools32 == 3.2.3-2 02:37:41 INFO - jsonschema == 2.5.1 02:37:41 INFO - manifestparser == 1.1 02:37:41 INFO - mozInstall == 1.12 02:37:41 INFO - mozcrash == 1.0 02:37:41 INFO - mozdebug == 0.1 02:37:41 INFO - mozdevice == 0.48 02:37:41 INFO - mozfile == 1.2 02:37:41 INFO - mozhttpd == 0.7 02:37:41 INFO - mozinfo == 0.9 02:37:41 INFO - mozleak == 0.1 02:37:41 INFO - mozlog == 3.4 02:37:41 INFO - moznetwork == 0.27 02:37:41 INFO - mozprocess == 0.23 02:37:41 INFO - mozprofile == 0.28 02:37:41 INFO - mozrunner == 6.13 02:37:41 INFO - mozscreenshot == 0.1 02:37:41 INFO - mozsystemmonitor == 0.3 02:37:41 INFO - moztest == 0.8 02:37:41 INFO - mozversion == 1.4 02:37:41 INFO - psutil == 3.1.1 02:37:41 INFO - requests == 1.2.3 02:37:41 INFO - wsgiref == 0.1.2 02:37:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:41 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 0x7f4970b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ffca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fcf60>, '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 0x21fdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21fe1d0>, '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': '1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:37:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:37:41 INFO - Using env: {'DISPLAY': ':0', 02:37:41 INFO - 'HOME': '/home/cltbld', 02:37:41 INFO - 'LANG': 'en_US.UTF-8', 02:37:41 INFO - 'LANGUAGE': 'en_US:en', 02:37:41 INFO - 'LOGNAME': 'cltbld', 02:37:41 INFO - 'MAIL': '/var/mail/cltbld', 02:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:41 INFO - 'MOZ_NO_REMOTE': '1', 02:37:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:41 INFO - 'NO_EM_RESTART': '1', 02:37:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:41 INFO - 'PWD': '/builds/slave/test', 02:37:41 INFO - 'SHELL': '/bin/bash', 02:37:41 INFO - 'SHLVL': '1', 02:37:41 INFO - 'TERM': 'linux', 02:37:41 INFO - 'TMOUT': '86400', 02:37:41 INFO - 'USER': 'cltbld', 02:37:41 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632', 02:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:41 INFO - '_': '/tools/buildbot/bin/python'} 02:37:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:37:41 INFO - Cleaning up... 02:37:41 INFO - Return code: 0 02:37:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:41 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 0x7f4970b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ffca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fcf60>, '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 0x21fdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21fe1d0>, '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': '1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:37:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:37:41 INFO - Using env: {'DISPLAY': ':0', 02:37:41 INFO - 'HOME': '/home/cltbld', 02:37:41 INFO - 'LANG': 'en_US.UTF-8', 02:37:41 INFO - 'LANGUAGE': 'en_US:en', 02:37:41 INFO - 'LOGNAME': 'cltbld', 02:37:41 INFO - 'MAIL': '/var/mail/cltbld', 02:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:41 INFO - 'MOZ_NO_REMOTE': '1', 02:37:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:41 INFO - 'NO_EM_RESTART': '1', 02:37:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:41 INFO - 'PWD': '/builds/slave/test', 02:37:41 INFO - 'SHELL': '/bin/bash', 02:37:41 INFO - 'SHLVL': '1', 02:37:41 INFO - 'TERM': 'linux', 02:37:41 INFO - 'TMOUT': '86400', 02:37:41 INFO - 'USER': 'cltbld', 02:37:41 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632', 02:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:41 INFO - '_': '/tools/buildbot/bin/python'} 02:37:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:37:41 INFO - Cleaning up... 02:37:41 INFO - Return code: 0 02:37:41 INFO - Running post-action listener: _resource_record_post_action 02:37:41 INFO - Running post-action listener: _start_resource_monitoring 02:37:41 INFO - Starting resource monitoring. 02:37:41 INFO - [mozharness: 2017-01-15 10:37:41.552802Z] Finished create-virtualenv step (success) 02:37:41 INFO - [mozharness: 2017-01-15 10:37:41.553244Z] Running install step. 02:37:41 INFO - Running pre-action listener: _resource_record_pre_action 02:37:41 INFO - Running main action method: install 02:37:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:37:41 INFO - Reading from file tmpfile_stdout 02:37:41 INFO - Detecting whether we're running mozinstall >=1.0... 02:37:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:37:41 INFO - Reading from file tmpfile_stdout 02:37:41 INFO - Output received: 02:37:41 INFO - Usage: mozinstall [options] installer 02:37:41 INFO - Options: 02:37:41 INFO - -h, --help show this help message and exit 02:37:41 INFO - -d DEST, --destination=DEST 02:37:41 INFO - Directory to install application into. [default: 02:37:41 INFO - "/builds/slave/test"] 02:37:41 INFO - --app=APP Application being installed. [default: firefox] 02:37:41 INFO - mkdir: /builds/slave/test/build/application 02:37:41 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'] 02:37:41 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 02:37:57 INFO - Reading from file tmpfile_stdout 02:37:57 INFO - Output received: 02:37:57 INFO - /builds/slave/test/build/application/firefox/firefox 02:37:57 INFO - Running post-action listener: _resource_record_post_action 02:37:57 INFO - [mozharness: 2017-01-15 10:37:57.803175Z] Finished install step (success) 02:37:57 INFO - [mozharness: 2017-01-15 10:37:57.803423Z] Running run-tests step. 02:37:57 INFO - Running pre-action listener: _resource_record_pre_action 02:37:57 INFO - Running main action method: run_tests 02:37:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:37:57 INFO - Python 2.7.3 02:37:57 INFO - Return code: 0 02:37:57 INFO - grabbing minidump binary from tooltool 02:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:57 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 0x21fcf60>, '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 0x21fdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21fe1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:37:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:37:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:37:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:37:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:37:58 INFO - Return code: 0 02:37:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:37:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:37:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:37:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:37:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:37:58 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/cupKHqifQJ6KBYAhzVElNA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:37:58 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/cupKHqifQJ6KBYAhzVElNA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:37:58 INFO - Using env: {'DISPLAY': ':0', 02:37:58 INFO - 'HOME': '/home/cltbld', 02:37:58 INFO - 'LANG': 'en_US.UTF-8', 02:37:58 INFO - 'LANGUAGE': 'en_US:en', 02:37:58 INFO - 'LOGNAME': 'cltbld', 02:37:58 INFO - 'MAIL': '/var/mail/cltbld', 02:37:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:37:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:58 INFO - 'MOZ_NO_REMOTE': '1', 02:37:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:37:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:58 INFO - 'NO_EM_RESTART': '1', 02:37:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:58 INFO - 'PWD': '/builds/slave/test', 02:37:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:37:58 INFO - 'SHELL': '/bin/bash', 02:37:58 INFO - 'SHLVL': '1', 02:37:58 INFO - 'TERM': 'linux', 02:37:58 INFO - 'TMOUT': '86400', 02:37:58 INFO - 'USER': 'cltbld', 02:37:58 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632', 02:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:58 INFO - '_': '/tools/buildbot/bin/python'} 02:37:58 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/cupKHqifQJ6KBYAhzVElNA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:37:58 INFO - mozversion application_buildid: 20170115004008 02:37:58 INFO - mozversion application_changeset: 1e04cc4582dd86864035f0aed5fac81907dea848 02:37:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:37:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:37:58 INFO - mozversion application_name: Firefox 02:37:58 INFO - mozversion application_remotingname: firefox-dev 02:37:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:37:58 INFO - mozversion application_vendor: Mozilla 02:37:58 INFO - mozversion application_version: 52.0a2 02:37:58 INFO - mozversion platform_buildid: 20170115004008 02:37:58 INFO - mozversion platform_changeset: 1e04cc4582dd86864035f0aed5fac81907dea848 02:37:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:37:58 INFO - mozversion platform_version: 52.0a2 02:37:58 INFO - using testdate: 1484476678 02:37:58 INFO - actual date: 1484476678 02:37:58 INFO - starting webserver on 'localhost:45290' 02:37:58 INFO - SUITE-START | Running 2 tests 02:37:58 INFO - TEST-START | dromaeo_css 02:37:58 INFO - operating with platform_type : linux_ 02:37:58 INFO - Initialising browser for dromaeo_css test... 02:37:58 INFO - TEST-INFO | started process 3331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj7yKUH/profile http://localhost:45290/getInfo.html) 02:38:03 INFO - PROCESS | 3331 | __metrics Screen width/height:1600/1200 02:38:03 INFO - PROCESS | 3331 | colorDepth:24 02:38:03 INFO - PROCESS | 3331 | Browser inner width/height: 1024/697 02:38:03 INFO - PROCESS | 3331 | __metrics 02:38:04 INFO - PROCESS | 3331 | 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" 02:38:04 INFO - PROCESS | 3331 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:38:04 INFO - PROCESS | 3331 | console.error: PushService: 02:38:04 INFO - PROCESS | 3331 | stateChangeProcessEnqueue: Error transitioning state 02:38:04 INFO - PROCESS | 3331 | UnknownError 02:38:05 INFO - TEST-INFO | 3331: exit 0 02:38:05 INFO - Browser initialized. 02:38:05 INFO - Running cycle 1/1 for dromaeo_css test... 02:38:05 INFO - TEST-INFO | started process 3422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj7yKUH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:38:17 INFO - PROCESS | 3422 | RSS: Main: 143863808 02:38:17 INFO - PROCESS | 3422 | 02:41:18 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:45290/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45290/tests/dromaeo/cssquery-ext.html) 02:41:20 INFO - PROCESS | 3422 | RSS: Main: 228294656 02:41:20 INFO - PROCESS | 3422 | 02:44:22 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:45290/tests/dromaeo/cssquery-ext.html (next: http://localhost:45290/tests/dromaeo/cssquery-jquery.html) 02:44:23 INFO - PROCESS | 3422 | RSS: Main: 224112640 02:44:23 INFO - PROCESS | 3422 | 02:47:25 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:45290/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45290/tests/dromaeo/cssquery-mootools.html) 02:47:25 INFO - PROCESS | 3422 | RSS: Main: 176848896 02:47:25 INFO - PROCESS | 3422 | 02:50:27 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:45290/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45290/tests/dromaeo/cssquery-prototype.html) 02:50:28 INFO - PROCESS | 3422 | RSS: Main: 173600768 02:50:28 INFO - PROCESS | 3422 | 02:53:30 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:45290/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45290/tests/dromaeo/cssquery-yui.html) 02:53:31 INFO - PROCESS | 3422 | RSS: Main: 176979968 02:53:31 INFO - PROCESS | 3422 | 02:56:33 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:45290/tests/dromaeo/cssquery-yui.html (next: http://localhost:45290/tests/dromaeo/cssquery-dojo.html) 02:56:34 INFO - PROCESS | 3422 | RSS: Main: 254406656 02:56:34 INFO - PROCESS | 3422 | 02:56:34 INFO - PROCESS | 3422 | __start_tp_report 02:56:34 INFO - PROCESS | 3422 | _x_x_mozilla_page_load 02:56:34 INFO - PROCESS | 3422 | _x_x_mozilla_page_load_details 02:56:34 INFO - PROCESS | 3422 | |i|pagename|runs| 02:56:34 INFO - PROCESS | 3422 | |0;dojo.html;3212.8072315661057;3254.040058182837;3267.705906468417;3275.13208999615;3288.7862288951214;5585.636933599319;5658.91511627326;5670.036093864042;5672.744726487308;5674.574406919477;5550.111982082867;5599.8600034999145;5611.691356975365;5612.607117501766;5627.296587926509;5072.79708811648;5096.643234973553;5119.360079990001;5121.385433747937;5156.510131537517;4929.285253638221;4955.08330958772;5148.150555158394;5154.536091751742;5192.844214673566;5019.0463811875625;5067.417247016603;5074.31496747938;5078.263651770491;5084.084864724348;5094.6433749637545;5144.511271429208;5154.92267615986;5185.351831021104;5186.92219616706;5104.387473503203;5196.090684130299;5200.947990520084;5213.556847667915;5247.212918062283;5379.085555455582;5417.945820541783;5653.547716182696;5658.547316214693;5745.885082298372;5896.439838215363;5935.614185077956;5938.346781853993;5985.8802823943715;6007.549433792483;6039.4262545058145;6048.606840555394;6059.0608455689;6062.787802426894;6065.423784740443;5408.675479471244;5468.070428027245;5621.718914054321;5637.915431268534;5647.181158731961;6039.909401358983;6075.939240607538;6086.05666121743;6156.6921653917125;6157.291911430153;5902.966980778432;5903.822885313448;5905.586608937333;5906.911396329058;5934.673592952429;5680.204771332017;5979.760809567569;5994.610350327215;5998.980173370537;6006.729697163638;5783.248177736951;5921.822345329647;5967.940320596738;5983.730732117066;6053.576249662481;6068.4538391544975;6069.605475644069;6077.8480537986015;6087.908681369783;6101.84745381369;4645.976770116128;4653.511381304982;4653.7207767534055;4669.603083737852;4678.742669153229;4000.299947509174;4039.5758445362812;4043.4137050127565;4103.076807718239;4156.584341565819;5663.263775709132;5688.374278829326;5706.343770466449;5713.457221563945;5729.1119876419225;5961.493273071751;6071.271447426248;6077.4226448487325;6082.9695851520455;6103.633781973096;5409.459054094637;5459.563234941195;5607.607467477319;5687.573431992617;5693.516051135617;5214.217867319857;5260.210968354778;5276.630635855453;5289.471052894757;5294.391145018295;6176.289726681399;6181.258249010058;6181.84545386369;6189.876202476015;6191.442770150708;5814.273215848019;5847.473727364558;6074.1799857020505;6078.118672792509;6086.969565152323;6034.939650603614;6057.545684073624;6073.180120683651;6169.444749972345;6179.69101544912;5902.232709747877;5914.142449344735;5923.496502797138;5927.40725927421;5931.911021334769;5735.426457354231;5959.851003724942;6013.819585412444;6043.425874541911;6047.909281360695;5638.6898720569125;5821.94178058214;5838.912416313674;5860.648361098348;5957.046872500379;5861.1501332307425;5893.263342082239;5895.882082358415;5908.734106965111;5920.3783602722815;5626.662400255834;5877.94122058774;5899.46904778572;5902.852428689317;5906;5754.108113242454;5849.210356601804;5864.266966629171;5894.616849904743;5995.850103747267;5776.277965254343;5824;5831.096180092092;5842.065269556851;5844.94155058444 02:56:34 INFO - PROCESS | 3422 | |1;ext.html;591.9378465261148;594.9583529152958;629.4460874430501;656.8522082531427;672.1228796420676;33869.66130338696;43576;44688.77655611718;44736.55263447364;44785.55214447855;47320.290195647096;47708.284375734394;47740.76129619347;47825;47838;8369.623366948472;8551.144885511461;8802.075782042873;8937.150970657776;8941.64233430662;10196;10440.94779526105;10443.68668939933;10708;10716.78566428671;10894.237403381767;10959.890401095967;10962;10963.56145754169;10968.561257549689;10772.946135269312;10837.512311945902;10839.729006774854;10842.295250808673;10842.566297348096;10707.411092389915;10764.73088172794;10774.946125269324;10775.515101820436;10779.514921828537;43699.781501092606;43805;43901.341479877825;43975.78012109951;44016.77991610021;3562.5724913010604;3752.399616061417;3868.7678739275734;3871.6515513603913;4150.003999040239;32737.672623273702;32890;32917.341653167045;33026.504602430985;33224.83387583047;4386.736795792231;4440.866773996785;4470.41884555009;4473.776311184428;4484;349182;353344;354216;354303.99999999744;355240;66077;66498;66568.66715666391;66664;66838;39173;40461;40507.79746101251;70030.64984675044;70273;18542.629147416978;18828.24687012504;18855.90572047131;18882.811171888105;18891.244350225836;12063.75872482563;12426.813597796041;12445.315507646985;12776.872231277754;12816.166949148275;19482.30238156819;21327.36017919465;21390.465238369165;21405;21471;7350.816229594196;7581.3176814087;7603.353714934182;7707.4604777666145;7851.528908265523;969.3892847506168;1049.6641074855972;1105.8396532502902;1132.4677401621389;1232.910217181886;31699.366012679617;34434.655653443144;34454.655453445645;34496.310073798384;34939.65060349364;1092.3609688332415;1125.2629527659396;1142.7771584540935;1158;1235.1477480538579;15628.687426251412;17822;18395;18855.15151818144;19211.807881921282;510702;753129;758242;758420;759564;65567.34432655708;66102.66948665322;66120.66939665271;66335.66832165905;66362.33637663562;1356.1727346318737;1404.8735613794604;1423.3418067950722;1452.4117732318427;1489.6499322659167;32278.515822262216;36234.456483152244;36423;37095.62904370922;37536.249275014896;60647;61292.38707612867;61406.69296653488;61442.69278653578;61466;455398;457143;457392;457697;460468;30967.69032309648;31766.364672706877;32023.839880801377;32070.839645802556;32073.198170045936;49633;49875.25187122269;50042.49957500524;50367;50506.74746626243;42536.361954570086;42603.57396425996;43100;43708;44246.557534425534;41906.58093419027;41917.79041104775;42152;43233;43446.56553434425;42511.57488425076;43047.78476107599;43247;43496.56503435052;43742;34131.65868341384;37189.6281037197;37926.810365948;38415.6158438412;39257;29269.41461170722;29492;29539.261518462212;29547.40905181927;29594 02:56:34 INFO - PROCESS | 3422 | |2;jquery.html;398.86438610872335;425.14121474621265;425.3470922134524;428.1266216917488;450.9661775366846;15400.537983860488;19094.809051909477;20085.698714519276;21292.4676883078;21475.67786483204;19593.314234001813;20505.897470512664;20716.48208794781;20782.16871325149;20962.371128866158;5697.316322041361;5915.024021036524;5919.260092488439;5919.674417907014;5924.37794031627;5634.746436410351;5870.794522191724;5898;5966.134910437984;5973.074173503114;5770.971145144268;5955.731992060346;5973.313068997078;5975;5975.0439929611275;5957.255343082114;6110.786122485736;6113.541484388688;6125.081237814341;6136.662483563425;5837.744884849735;5895.41045895407;5928.784599157162;6042.788502402394;6066.181065556182;14538.491152809602;14704.117752934751;14955.850441495555;15099.169545674984;15205.239738013166;2363.2319496163814;2464.507098580273;2514.270861450177;2581.1611226351324;2583.573710337792;10316.174706023576;10799.622013229578;11086.61196858106;11348.09215262777;11455.942720286428;1981.4550998475534;2015.858889877709;2036.7352244208307;2060.8351331893414;2068.9482762930897;78021.21978780253;80337.59831200865;80944.59527702324;93241.53379233128;97764.51117744365;10737.731556711145;11598;11890.346030968207;11941.70145746346;11975.161738678209;15246.847531524543;16009.919950400174;16097.758533622005;16112.75830862538;16696.83303166953;7106.253843346478;8877.112288771072;9082.003918275937;9087.045860184717;9236.769080773034;8408.453450525696;8544.40189186751;8729.781755456037;8751.431156974777;8946.150115738994;5051.545360917535;5071.188609822484;5130.333056702605;5137.2037334213255;5143.871403214949;2059.6704527275565;2083.874967501955;2095.402810199086;2099.8240985048114;2149.9032543535577;962.3456049886145;962.870012548311;980.9362391444533;989.1147423056468;1045.451138152476;20056.498587535138;20441.897790510953;20524;20562.69155962662;20713.585728285652;1031.3811712972306;1033.8707661542308;1047.3401756893109;1052.3528030261486;1079.4279032112836;10622.93770622947;11795.469203885847;11894.16740828151;11990.820137697941;11993.88006119945;377203;461651;466817;480225;481415;95247;96299;99197.50401248092;100110.49944750375;101133;1013.6249587652468;1023.81059503992;1032.607609108534;1035.321864178964;1035.8394448860288;17887.37394191197;17921.19354629019;18104.818951810314;18401.171947262672;18862;44313;44521.33218001668;44550.55449445464;45209.54790452185;46350.30474542817;61624.38375616366;62315;62753;65276;65395;8838.734837954871;8942.73171804847;9006.54967251648;9019.774505637411;9316.813663726552;10116;12525.498980040697;12990.220586764824;13296.734065318833;14135.434582616992;11604.6518604442;11812.409379530816;12175.452104655134;12249.816252756038;12393.194442361219;11591.826122608;11614.419279035845;11638.592649257236;11991.460384282902;12516.687082823002;11803.468843901874;12014.219075760047;12114.939425302817;12173.39133043362;12218.816717749063;9198.586063627019;9207.447553146832;9211.723648290563;9288.814223715623;9357.625694972125;10194.43930583825;11740.530378784753;11984.40077996114;12175.39123043862;12189.878101218874 02:56:34 INFO - PROCESS | 3422 | |3;mootools.html;1369.0827145812318;1481.2889812889812;1512.009633689933;1685.7892763404575;1828.890266584006;7788.260115289053;8430.452020618655;8686.261667758232;8699.39104262702;8927.508987005713;8751.95624021879;8821.161989610993;8823.338249631272;8824;8829.117088291168;2497.962530562043;2522.3567990162483;2524.936876578091;2528.5954247320433;2528.696556413224;2468.6790717206736;2555.642210090589;2558.9488210235786;2564.4742827720274;2566.2044766122467;2481.0695989004125;2482.553140434721;2513.5726926422553;2515.4591762771092;2516.3331717094893;2306.3542208181734;2343.250159948817;2361.551305252005;2444.107900616262;2448.033026954361;2410.072122232953;2455.4229756007326;2465.174166654173;2488.962665560018;2491.950160996788;8494.78763030923;8804.339674524435;8874;8879.600417981143;8883.955580222058;5452.809151679712;5667.631603945731;5667.744951477193;5670.914936275959;5675.063614503602;3500.3349363621087;3641.6540428659237;3646.781193128421;3698.6301369863068;3713.740038197327;1185.478389508622;1188.597455003096;1232.4577186038114;1235.1786062268582;1240.962771116868;12520.186187897758;12695.55565555201;12696.746065078647;12707.364631768467;12712.110152289344;4489.842855500042;4681.531846815359;4749.311349854252;4754.524547545287;4787.042591481718;9694.175995040501;9755.170810481188;9763.804723905625;9777.853332200022;9782.75543111428;5515.834524964257;5523.254360661259;5524.1989911462615;5525.917111243334;5527.060399731975;4365.410669559632;4443.955560444419;4949.925751113737;4988.501149884983;5140.3831540215415;3940.763554186758;3986.8405263789705;4048.716589838683;4081.8979525511504;4091.3453847384276;1243.490169030693;1257.8113283007622;1264.051961029228;1266.6073517209695;1269.2321145706899;997.0976266478848;999;1008.8537162111453;1014.91373233276;1023.2019025160387;6052.182955300978;6178.104174894705;6344.111824344595;6359.7456101755415;6581.934180658228;477.68472807947285;478.3757196858064;486.2463182067781;488.62620095626875;508.22241969786285;4437.711548749321;4445.155420470101;4462.152191083684;4482;4507.639388848885;10644.840327395095;10968.451577421098;11067.169962252863;11082.390468524309;11084.279521831055;11032.227744057838;11033.779324413626;11036.282641628268;11043.392613406178;11053.668389948314;7898.2891539761695;8194.959025204837;8203.220694034057;8370.455920365157;8370.707025254209;6201.875962480815;6244.219472565929;6423.261324947691;6432.625814446222;6519.706613202512;9878.209743220668;9882.160016398399;9937.801243975224;10037.849432258376;10314;10233.795324093626;10282.640107596199;10328.483575821028;10334.328268662814;10357.378557286587;7484.176740558643;7678.961605191938;7774.378049755893;7870.645820938186;7921.485103468256;8458.28104611115;8509.276711479593;8561.657533698832;8571.528565928933;8582;7497.662605182671;7608.467407281437;7630.885536716843;7682.154962954182;7752.108507521707;7442.367398771165;7460.626968651654;7506.13679426851;7575.393968482398;7776.7278145264645;6836.350546698056;6889.552179108542;6931.202911665223;6931.584104953719;7055.365017148276;5322.467753224647;5452.236686863763;5511.255980442589;5547.833564993057;5602.775888964559;5471.781128754806;5490.450954904637;5497.725113744376;5622.100463925753;5692.686902220252 02:56:34 INFO - PROCESS | 3422 | |4;prototype.html;355.22560817418025;364.8595290813036;365.20932181826345;368.0834721543356;374.9456328832318;5353.170258609917;5396.866658001814;5400.108982017962;5407.729613519318;5425.674459532431;5305.124654432014;5322.068637988346;5326.440723724002;5333.599980001506;5339.813106541272;4129.1328820947565;4171.895702607444;4210.031692710679;4211.178820130076;4222.986483244014;4198.391233271173;4205.327147656376;4205.558416366283;4207.579242075783;4222.683298752606;4177.582241775828;4181.393697913801;4193.706440549163;4194.538600753915;4194.937075943863;4096.508418989725;4164.937525937114;4172.4993000840095;4194.769287689176;4194.895127621803;3709.2952339055764;3710.6845918096724;3712.554493460775;3716.1267102230954;3716.535433070866;5195.064888320101;5205.141151709963;5216.295800067019;5226.477352264781;5230.424653288173;4650;4655.439508270471;4712.599429048535;4749.525047495257;4759.286107083931;5493.626593351662;5514.476124768141;5528.474794894479;5530.253415788898;5541.196526503634;4053.067794407273;4053.8581149659917;4053.97973010136;4063.553009168989;4065.9390109148385;5575.944240557583;5719.456651618089;5723.513501352431;5765.711714414305;5797.246357973437;4125.1749650069505;4130.339145736668;4142.357934520154;4156.58434156588;4158.91682166355;4184.267753143188;4215.924939140499;4216.7259128156575;4217.768022758716;4217.936730949038;4640.5359464054;4761.309610106515;4761.500042495557;4766.523347665275;4781.928271075936;5562.749676264497;5564.888702225933;5584.329880414376;5598.776048957996;5600.215969764236;1385.778275475919;1397.7071209131716;1397.9790303145462;1402.7194561087824;1407.3596513586294;929.3726734454216;979.0747743382577;983.4541829284673;989.5453683085852;993.9353941993892;5176.378834539879;5183.015227106837;5194.844154675366;5202.895942081137;5203.115470370046;5498.5876059295715;5509.889802204014;5521.2270282160525;5529.30883639545;5533.3083364579425;4945.7774400152075;5181.248718935809;5182.792688292501;5190.558802501754;5248.160294352885;2884.4952133376996;2911.344947386821;2913.810602310843;2914.533674612052;2928.604638373835;5590.664560126405;5616.146671598362;5642.774289028475;5644.081012455785;5656.91514627281;5362.2224777407055;5560.7219639017885;5575.275214222125;5580.632744977506;5588.524975377057;5719.628224165416;5731.398203188689;5821.27234095738;5842;5847.853803654943;5675.7445914933105;5734.99637563433;5739.0243658578975;5758.481736643722;5766.163906233489;5531.0873705839695;5635.211070450058;5645.1532270159805;5645.532161638086;5677.858053548694;5842.269716285465;5843.590948633555;5848.941510584839;5848.970755146197;5861.794837180678;4101.589841015994;4110.725675040747;4120.876373708794;4121.835126595022;4134.937975930424;5548.946889650855;5664.971675141598;5739.2252045973255;5743.56923230751;5765.279340082489;5576.944230557642;5588.91016251827;5590.888182236251;5597.776088956559;5620.325560932714;5337.199420087018;5548.361938377138;5566.944330556643;5608.130739735348;5610.579206559442;5528.7235638218735;5570.888582228252;5571.303587051619;5579.776808927598;5591.9720401397735;5634.380218175916;5637.267155269788;5641.238432811518;5647.858803529944;5654.575906807088;5259.39516955555;5486.259354987025;5515.283013208417;5517.806876759294;5524.281843360337 02:56:34 INFO - PROCESS | 3422 | |5;yui.html;711.918129415117;757.469771160188;800.427694198648;815.3192084609351;839.1608391608391;13749.725005499884;14151.221682807442;14441.638959026004;14462.855371446283;14462.927685361572;12476.875231247684;12531.2481251125;12556.309402982832;12557.121001529897;12564;695.5166159519149;725.5066554742799;830.983380332393;862.3015357560396;874.2350443362059;866.6966561703385;867.5878957495171;867.8090820019618;868.5743985447117;868.9956550217272;734.8016035670365;918.8346097702411;922.2760133295365;922.349743430883;922.423485321674;765.9272369124924;879.5865943006777;910.2626872233479;914.6067191107821;917.0462718772469;673.1854456108115;673.9224989126216;675.7060678604822;675.8715843989626;675.8952362383839;13336;13762.65593360164;13844.93077534616;13854.930725346308;13901.16593004423;13370.197788132646;13793.517226897111;13824.930875345559;13971.161730296113;14032.1580705157;12195.14633975622;12323.383830808423;12354.840789924057;12363.781253112842;12434.81347779784;4321.675874309408;4347.739135651871;4369.868903932856;4425.889352766175;4447.510773814878;63357.683211583644;64119.67940160316;64177.03734443987;65380.3461965379;65564;10770.869058748875;10796.730081748019;10829.783404331869;11043.116550675926;11045.558177672803;20578.176872925214;20634.79365206359;20649.483762906046;20672.58654826895;20681.482962925747;8091.635876385577;8093.595320233965;8362.54006029662;8400.369972252105;8419.705310314232;4359.891002724894;4423.181711383404;4480.103979204172;4534.954650453519;4686.203345431285;3514.1741690702665;3670.541182352206;3683.9631603684156;3684.447332900033;3686.889393318205;649.1042361541043;649.8635286589774;652.6084349390422;663.6582160187507;675.3988949834651;718.1956209045902;751.4289140253337;773.9187385324573;774.4772278711847;786.8544319300947;9253.444793312423;9415.435073895589;9444.527773611291;9721.416714997124;9734.75663108428;677.7526202935992;756.6897571995455;763.0957315581054;775.4726785785607;775.9806004849924;4673.602743766818;4873.269009648581;4891.877703057452;4903.8528844134735;4938.703677779345;82239;86678;86905.5654721735;89999;90384.5480772592;50417.99164016699;66582.66708666425;66773;67163;78748.60625696834;65768.99999999904;66349.66825165843;66546.33453665402;68621.31378686149;68792;9080.772980675536;9207.76980575491;9555.426674399558;9606.711798646053;9805.754856128653;46613.06773864572;47285.763571181924;47346.28980565363;48236;49423.25865112098;62536.37463625306;63323.36676633175;63360.68319658372;63638.68180659067;65919;12265.57070502528;12311;12350.135490515937;12431.378431078228;12768.233905965672;13650.112742671694;13728.65678358049;13730.588082357544;13814.516491922734;14562.927185364006;12873.871261287642;12933.870661293644;13596.796048059485;13654.86345136536;13954.651133721738;12343.629691109281;12400.875991240333;12702.237865728086;13497.86502134966;13509.662258443617;12525.686857828627;12780.297083660487;12992.935035324763;13021.739565208833;13427.462901483832;10962;11074.446277686244;11080;11162.776744465227;11658.18392712536;10931.289466184673;11200;11470.197086203885;11546.307221566733;11685.474153662935 02:56:34 INFO - PROCESS | 3422 | __end_tp_report 02:56:34 INFO - PROCESS | 3422 | __start_cc_report 02:56:34 INFO - PROCESS | 3422 | _x_x_mozilla_cycle_collect,1305 02:56:34 INFO - PROCESS | 3422 | __end_cc_report 02:56:34 INFO - PROCESS | 3422 | __startTimestamp1484477794171__endTimestamp 02:56:34 INFO - PROCESS | 3422 | 02:56:34 INFO - PROCESS | 3422 | ------- Summary: start ------- 02:56:34 INFO - PROCESS | 3422 | Number of tests: 6 02:56:34 INFO - PROCESS | 3422 | 02:56:34 INFO - PROCESS | 3422 | [#0] dojo.html Cycles:165 Average:5574.19 Median:5814.27 stddev:624.14 (10.7%) stddev-sans-first:597.93 02:56:34 INFO - PROCESS | 3422 | Values: 3212.8 3254.0 3267.7 3275.1 3288.8 5585.6 5658.9 5670.0 5672.7 5674.6 5550.1 5599.9 5611.7 5612.6 5627.3 5072.8 5096.6 5119.4 5121.4 5156.5 4929.3 4955.1 5148.2 5154.5 5192.8 5019.0 5067.4 5074.3 5078.3 5084.1 5094.6 5144.5 5154.9 5185.4 5186.9 5104.4 5196.1 5200.9 5213.6 5247.2 5379.1 5417.9 5653.5 5658.5 5745.9 5896.4 5935.6 5938.3 5985.9 6007.5 6039.4 6048.6 6059.1 6062.8 6065.4 5408.7 5468.1 5621.7 5637.9 5647.2 6039.9 6075.9 6086.1 6156.7 6157.3 5903.0 5903.8 5905.6 5906.9 5934.7 5680.2 5979.8 5994.6 5999.0 6006.7 5783.2 5921.8 5967.9 5983.7 6053.6 6068.5 6069.6 6077.8 6087.9 6101.8 4646.0 4653.5 4653.7 4669.6 4678.7 4000.3 4039.6 4043.4 4103.1 4156.6 5663.3 5688.4 5706.3 5713.5 5729.1 5961.5 6071.3 6077.4 6083.0 6103.6 5409.5 5459.6 5607.6 5687.6 5693.5 5214.2 5260.2 5276.6 5289.5 5294.4 6176.3 6181.3 6181.8 6189.9 6191.4 5814.3 5847.5 6074.2 6078.1 6087.0 6034.9 6057.5 6073.2 6169.4 6179.7 5902.2 5914.1 5923.5 5927.4 5931.9 5735.4 5959.9 6013.8 6043.4 6047.9 5638.7 5821.9 5838.9 5860.6 5957.0 5861.2 5893.3 5895.9 5908.7 5920.4 5626.7 5877.9 5899.5 5902.9 5906.0 5754.1 5849.2 5864.3 5894.6 5995.9 5776.3 5824.0 5831.1 5842.1 5844.9 02:56:34 INFO - PROCESS | 3422 | 02:56:34 INFO - PROCESS | 3422 | [#1] ext.html Cycles:180 Average:67267.33 Median:21142.19 stddev:141875.87 (671.1%) stddev-sans-first:142185.55 02:56:34 INFO - PROCESS | 3422 | Values: 591.9 595.0 629.4 656.9 672.1 33869.7 43576.0 44688.8 44736.6 44785.6 47320.3 47708.3 47740.8 47825.0 47838.0 8369.6 8551.1 8802.1 8937.2 8941.6 10196.0 10440.9 10443.7 10708.0 10716.8 10894.2 10959.9 10962.0 10963.6 10968.6 10772.9 10837.5 10839.7 10842.3 10842.6 10707.4 10764.7 10774.9 10775.5 10779.5 43699.8 43805.0 43901.3 43975.8 44016.8 3562.6 3752.4 3868.8 3871.7 4150.0 32737.7 32890.0 32917.3 33026.5 33224.8 4386.7 4440.9 4470.4 4473.8 4484.0 349182.0 353344.0 354216.0 354304.0 355240.0 66077.0 66498.0 66568.7 66664.0 66838.0 39173.0 40461.0 40507.8 70030.6 70273.0 18542.6 18828.2 18855.9 18882.8 18891.2 12063.8 12426.8 12445.3 12776.9 12816.2 19482.3 21327.4 21390.5 21405.0 21471.0 7350.8 7581.3 7603.4 7707.5 7851.5 969.4 1049.7 1105.8 1132.5 1232.9 31699.4 34434.7 34454.7 34496.3 34939.7 1092.4 1125.3 1142.8 1158.0 1235.1 15628.7 17822.0 18395.0 18855.2 19211.8 510702.0 753129.0 758242.0 758420.0 759564.0 65567.3 66102.7 66120.7 66335.7 66362.3 1356.2 1404.9 1423.3 1452.4 1489.6 32278.5 36234.5 36423.0 37095.6 37536.2 60647.0 61292.4 61406.7 61442.7 61466.0 455398.0 457143.0 457392.0 457697.0 460468.0 30967.7 31766.4 32023.8 32070.8 32073.2 49633.0 49875.3 50042.5 50367.0 50506.7 42536.4 42603.6 43100.0 43708.0 44246.6 41906.6 41917.8 42152.0 43233.0 43446.6 42511.6 43047.8 43247.0 43496.6 43742.0 34131.7 37189.6 37926.8 38415.6 39257.0 29269.4 29492.0 29539.3 29547.4 29594.0 02:56:34 INFO - PROCESS | 3422 | 02:56:34 INFO - PROCESS | 3422 | [#2] jquery.html Cycles:180 Average:28642.03 Median:21384.07 stddev:75582.53 (353.5%) stddev-sans-first:75764.81 02:56:34 INFO - PROCESS | 3422 | Values: 398.9 425.1 425.3 428.1 451.0 15400.5 19094.8 20085.7 21292.5 21475.7 19593.3 20505.9 20716.5 20782.2 20962.4 5697.3 5915.0 5919.3 5919.7 5924.4 5634.7 5870.8 5898.0 5966.1 5973.1 5771.0 5955.7 5973.3 5975.0 5975.0 5957.3 6110.8 6113.5 6125.1 6136.7 5837.7 5895.4 5928.8 6042.8 6066.2 14538.5 14704.1 14955.9 15099.2 15205.2 2363.2 2464.5 2514.3 2581.2 2583.6 10316.2 10799.6 11086.6 11348.1 11455.9 1981.5 2015.9 2036.7 2060.8 2068.9 78021.2 80337.6 80944.6 93241.5 97764.5 10737.7 11598.0 11890.3 11941.7 11975.2 15246.8 16009.9 16097.8 16112.8 16696.8 7106.3 8877.1 9082.0 9087.0 9236.8 8408.5 8544.4 8729.8 8751.4 8946.2 5051.5 5071.2 5130.3 5137.2 5143.9 2059.7 2083.9 2095.4 2099.8 2149.9 962.3 962.9 980.9 989.1 1045.5 20056.5 20441.9 20524.0 20562.7 20713.6 1031.4 1033.9 1047.3 1052.4 1079.4 10622.9 11795.5 11894.2 11990.8 11993.9 377203.0 461651.0 466817.0 480225.0 481415.0 95247.0 96299.0 99197.5 100110.5 101133.0 1013.6 1023.8 1032.6 1035.3 1035.8 17887.4 17921.2 18104.8 18401.2 18862.0 44313.0 44521.3 44550.6 45209.5 46350.3 61624.4 62315.0 62753.0 65276.0 65395.0 8838.7 8942.7 9006.5 9019.8 9316.8 10116.0 12525.5 12990.2 13296.7 14135.4 11604.7 11812.4 12175.5 12249.8 12393.2 11591.8 11614.4 11638.6 11991.5 12516.7 11803.5 12014.2 12114.9 12173.4 12218.8 9198.6 9207.4 9211.7 9288.8 9357.6 10194.4 11740.5 11984.4 12175.4 12189.9 02:56:34 INFO - PROCESS | 3422 | 02:56:34 INFO - PROCESS | 3422 | [#3] mootools.html Cycles:180 Average:5885.57 Median:2719.28 stddev:3274.14 (120.4%) stddev-sans-first:3265.73 02:56:34 INFO - PROCESS | 3422 | Values: 1369.1 1481.3 1512.0 1685.8 1828.9 7788.3 8430.5 8686.3 8699.4 8927.5 8752.0 8821.2 8823.3 8824.0 8829.1 2498.0 2522.4 2524.9 2528.6 2528.7 2468.7 2555.6 2558.9 2564.5 2566.2 2481.1 2482.6 2513.6 2515.5 2516.3 2306.4 2343.3 2361.6 2444.1 2448.0 2410.1 2455.4 2465.2 2489.0 2492.0 8494.8 8804.3 8874.0 8879.6 8884.0 5452.8 5667.6 5667.7 5670.9 5675.1 3500.3 3641.7 3646.8 3698.6 3713.7 1185.5 1188.6 1232.5 1235.2 1241.0 12520.2 12695.6 12696.7 12707.4 12712.1 4489.8 4681.5 4749.3 4754.5 4787.0 9694.2 9755.2 9763.8 9777.9 9782.8 5515.8 5523.3 5524.2 5525.9 5527.1 4365.4 4444.0 4949.9 4988.5 5140.4 3940.8 3986.8 4048.7 4081.9 4091.3 1243.5 1257.8 1264.1 1266.6 1269.2 997.1 999.0 1008.9 1014.9 1023.2 6052.2 6178.1 6344.1 6359.7 6581.9 477.7 478.4 486.2 488.6 508.2 4437.7 4445.2 4462.2 4482.0 4507.6 10644.8 10968.5 11067.2 11082.4 11084.3 11032.2 11033.8 11036.3 11043.4 11053.7 7898.3 8195.0 8203.2 8370.5 8370.7 6201.9 6244.2 6423.3 6432.6 6519.7 9878.2 9882.2 9937.8 10037.8 10314.0 10233.8 10282.6 10328.5 10334.3 10357.4 7484.2 7679.0 7774.4 7870.6 7921.5 8458.3 8509.3 8561.7 8571.5 8582.0 7497.7 7608.5 7630.9 7682.2 7752.1 7442.4 7460.6 7506.1 7575.4 7776.7 6836.4 6889.6 6931.2 6931.6 7055.4 5322.5 5452.2 5511.3 5547.8 5602.8 5471.8 5490.5 5497.7 5622.1 5692.7 02:56:34 INFO - PROCESS | 3422 | 02:56:34 INFO - PROCESS | 3422 | [#4] prototype.html Cycles:180 Average:4676.88 Median:5338.51 stddev:1353.59 (25.4%) stddev-sans-first:1317.95 02:56:34 INFO - PROCESS | 3422 | Values: 355.2 364.9 365.2 368.1 374.9 5353.2 5396.9 5400.1 5407.7 5425.7 5305.1 5322.1 5326.4 5333.6 5339.8 4129.1 4171.9 4210.0 4211.2 4223.0 4198.4 4205.3 4205.6 4207.6 4222.7 4177.6 4181.4 4193.7 4194.5 4194.9 4096.5 4164.9 4172.5 4194.8 4194.9 3709.3 3710.7 3712.6 3716.1 3716.5 5195.1 5205.1 5216.3 5226.5 5230.4 4650.0 4655.4 4712.6 4749.5 4759.3 5493.6 5514.5 5528.5 5530.3 5541.2 4053.1 4053.9 4054.0 4063.6 4065.9 5575.9 5719.5 5723.5 5765.7 5797.2 4125.2 4130.3 4142.4 4156.6 4158.9 4184.3 4215.9 4216.7 4217.8 4217.9 4640.5 4761.3 4761.5 4766.5 4781.9 5562.7 5564.9 5584.3 5598.8 5600.2 1385.8 1397.7 1398.0 1402.7 1407.4 929.4 979.1 983.5 989.5 993.9 5176.4 5183.0 5194.8 5202.9 5203.1 5498.6 5509.9 5521.2 5529.3 5533.3 4945.8 5181.2 5182.8 5190.6 5248.2 2884.5 2911.3 2913.8 2914.5 2928.6 5590.7 5616.1 5642.8 5644.1 5656.9 5362.2 5560.7 5575.3 5580.6 5588.5 5719.6 5731.4 5821.3 5842.0 5847.9 5675.7 5735.0 5739.0 5758.5 5766.2 5531.1 5635.2 5645.2 5645.5 5677.9 5842.3 5843.6 5848.9 5849.0 5861.8 4101.6 4110.7 4120.9 4121.8 4134.9 5548.9 5665.0 5739.2 5743.6 5765.3 5576.9 5588.9 5590.9 5597.8 5620.3 5337.2 5548.4 5566.9 5608.1 5610.6 5528.7 5570.9 5571.3 5579.8 5592.0 5634.4 5637.3 5641.2 5647.9 5654.6 5259.4 5486.3 5515.3 5517.8 5524.3 02:56:34 INFO - PROCESS | 3422 | 02:56:34 INFO - PROCESS | 3422 | [#5] yui.html Cycles:180 Average:17623.68 Median:4882.57 stddev:22906.05 (469.1%) stddev-sans-first:22935.10 02:56:34 INFO - PROCESS | 3422 | Values: 711.9 757.5 800.4 815.3 839.2 13749.7 14151.2 14441.6 14462.9 14462.9 12476.9 12531.2 12556.3 12557.1 12564.0 695.5 725.5 831.0 862.3 874.2 866.7 867.6 867.8 868.6 869.0 734.8 918.8 922.3 922.3 922.4 765.9 879.6 910.3 914.6 917.0 673.2 673.9 675.7 675.9 675.9 13336.0 13762.7 13844.9 13854.9 13901.2 13370.2 13793.5 13824.9 13971.2 14032.2 12195.1 12323.4 12354.8 12363.8 12434.8 4321.7 4347.7 4369.9 4425.9 4447.5 63357.7 64119.7 64177.0 65380.3 65564.0 10770.9 10796.7 10829.8 11043.1 11045.6 20578.2 20634.8 20649.5 20672.6 20681.5 8091.6 8093.6 8362.5 8400.4 8419.7 4359.9 4423.2 4480.1 4535.0 4686.2 3514.2 3670.5 3684.0 3684.4 3686.9 649.1 649.9 652.6 663.7 675.4 718.2 751.4 773.9 774.5 786.9 9253.4 9415.4 9444.5 9721.4 9734.8 677.8 756.7 763.1 775.5 776.0 4673.6 4873.3 4891.9 4903.9 4938.7 82239.0 86678.0 86905.6 89999.0 90384.5 50418.0 66582.7 66773.0 67163.0 78748.6 65769.0 66349.7 66546.3 68621.3 68792.0 9080.8 9207.8 9555.4 9606.7 9805.8 46613.1 47285.8 47346.3 48236.0 49423.3 62536.4 63323.4 63360.7 63638.7 65919.0 12265.6 12311.0 12350.1 12431.4 12768.2 13650.1 13728.7 13730.6 13814.5 14562.9 12873.9 12933.9 13596.8 13654.9 13954.7 12343.6 12400.9 12702.2 13497.9 13509.7 12525.7 12780.3 12992.9 13021.7 13427.5 10962.0 11074.4 11080.0 11162.8 11658.2 10931.3 11200.0 11470.2 11546.3 11685.5 02:56:34 INFO - PROCESS | 3422 | -------- Summary: end -------- 02:56:34 INFO - PROCESS | 3422 | 02:56:34 INFO - TEST-INFO | 3422: exit 0 02:56:34 INFO - TEST-OK | dromaeo_css | took 1116434ms 02:56:34 INFO - TEST-START | kraken 02:56:34 INFO - operating with platform_type : linux_ 02:56:34 INFO - Initialising browser for kraken test... 02:56:34 INFO - TEST-INFO | started process 3741 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCu9GXY/profile http://localhost:45290/getInfo.html) 02:56:39 INFO - PROCESS | 3741 | __metrics Screen width/height:1600/1200 02:56:39 INFO - PROCESS | 3741 | colorDepth:24 02:56:39 INFO - PROCESS | 3741 | Browser inner width/height: 1024/697 02:56:39 INFO - PROCESS | 3741 | __metrics 02:56:39 INFO - PROCESS | 3741 | 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" 02:56:39 INFO - PROCESS | 3741 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:56:40 INFO - PROCESS | 3741 | console.error: PushService: 02:56:40 INFO - PROCESS | 3741 | stateChangeProcessEnqueue: Error transitioning state 02:56:40 INFO - PROCESS | 3741 | UnknownError 02:56:40 INFO - TEST-INFO | 3741: exit 0 02:56:40 INFO - Browser initialized. 02:56:40 INFO - Running cycle 1/1 for kraken test... 02:56:40 INFO - TEST-INFO | started process 3831 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCu9GXY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:56:52 INFO - PROCESS | 3831 | RSS: Main: 147161088 02:56:52 INFO - PROCESS | 3831 | 02:56:54 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:45290/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45290/tests/kraken/driver.html?testName=audio-beat-detection) 02:56:55 INFO - PROCESS | 3831 | RSS: Main: 188833792 02:56:55 INFO - PROCESS | 3831 | 02:56:58 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:45290/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45290/tests/kraken/driver.html?testName=audio-dft) 02:56:58 INFO - PROCESS | 3831 | RSS: Main: 178241536 02:56:58 INFO - PROCESS | 3831 | 02:57:01 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:45290/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45290/tests/kraken/driver.html?testName=audio-fft) 02:57:02 INFO - PROCESS | 3831 | RSS: Main: 269471744 02:57:02 INFO - PROCESS | 3831 | 02:57:04 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:45290/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45290/tests/kraken/driver.html?testName=audio-oscillator) 02:57:04 INFO - PROCESS | 3831 | RSS: Main: 176574464 02:57:04 INFO - PROCESS | 3831 | 02:57:07 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:45290/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45290/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:57:07 INFO - PROCESS | 3831 | RSS: Main: 179126272 02:57:07 INFO - PROCESS | 3831 | 02:57:10 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:45290/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45290/tests/kraken/driver.html?testName=imaging-darkroom) 02:57:11 INFO - PROCESS | 3831 | RSS: Main: 217858048 02:57:11 INFO - PROCESS | 3831 | 02:57:14 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:45290/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45290/tests/kraken/driver.html?testName=imaging-desaturate) 02:57:15 INFO - PROCESS | 3831 | RSS: Main: 216264704 02:57:15 INFO - PROCESS | 3831 | 02:57:17 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:45290/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45290/tests/kraken/driver.html?testName=json-parse-financial) 02:57:18 INFO - PROCESS | 3831 | RSS: Main: 214605824 02:57:18 INFO - PROCESS | 3831 | 02:57:19 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:45290/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45290/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:57:20 INFO - PROCESS | 3831 | RSS: Main: 177225728 02:57:20 INFO - PROCESS | 3831 | 02:57:22 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:45290/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45290/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:57:22 INFO - PROCESS | 3831 | RSS: Main: 183865344 02:57:22 INFO - PROCESS | 3831 | 02:57:25 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:45290/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45290/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:57:25 INFO - PROCESS | 3831 | RSS: Main: 189624320 02:57:25 INFO - PROCESS | 3831 | 02:57:27 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:45290/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:57:28 INFO - PROCESS | 3831 | RSS: Main: 198627328 02:57:28 INFO - PROCESS | 3831 | 02:57:31 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:45290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:57:31 INFO - PROCESS | 3831 | RSS: Main: 195289088 02:57:31 INFO - PROCESS | 3831 | 02:57:33 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:45290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45290/tests/kraken/driver.html?testName=ai-astar) 02:57:33 INFO - PROCESS | 3831 | RSS: Main: 246996992 02:57:33 INFO - PROCESS | 3831 | 02:57:33 INFO - PROCESS | 3831 | __start_tp_report 02:57:33 INFO - PROCESS | 3831 | _x_x_mozilla_page_load 02:57:33 INFO - PROCESS | 3831 | _x_x_mozilla_page_load_details 02:57:33 INFO - PROCESS | 3831 | |i|pagename|runs| 02:57:33 INFO - PROCESS | 3831 | |0;ai-astar;99;111;110;109;112;111;110;111;111;110 02:57:33 INFO - PROCESS | 3831 | |1;audio-beat-detection;155;117;118;153;122;121;117;123;155;118 02:57:33 INFO - PROCESS | 3831 | |2;audio-dft;160;160;162;164;164;160;160;160;159;159 02:57:33 INFO - PROCESS | 3831 | |3;audio-fft;76;75;74;113;74;74;75;74;95;74 02:57:33 INFO - PROCESS | 3831 | |4;audio-oscillator;82;81;117;82;83;82;105;81;82;100 02:57:33 INFO - PROCESS | 3831 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;116;117 02:57:33 INFO - PROCESS | 3831 | |6;imaging-darkroom;147;146;146;146;146;146;146;146;147;146 02:57:33 INFO - PROCESS | 3831 | |7;imaging-desaturate;86;84;84;84;85;85;84;85;85;85 02:57:33 INFO - PROCESS | 3831 | |8;json-parse-financial;51;47;50;49;49;50;51;49;49;60 02:57:33 INFO - PROCESS | 3831 | |9;json-stringify-tinderbox;58;60;59;58;63;60;58;59;59;58 02:57:33 INFO - PROCESS | 3831 | |10;stanford-crypto-aes;75;75;75;75;74;77;76;80;74;80 02:57:33 INFO - PROCESS | 3831 | |11;stanford-crypto-ccm;122;120;119;121;119;121;121;139;160;121 02:57:33 INFO - PROCESS | 3831 | |12;stanford-crypto-pbkdf2;151;153;151;152;151;151;151;150;151;151 02:57:33 INFO - PROCESS | 3831 | |13;stanford-crypto-sha256-iterative;62;63;61;61;64;61;63;61;61;62 02:57:33 INFO - PROCESS | 3831 | __end_tp_report 02:57:33 INFO - PROCESS | 3831 | __start_cc_report 02:57:33 INFO - PROCESS | 3831 | _x_x_mozilla_cycle_collect,1610 02:57:33 INFO - PROCESS | 3831 | __end_cc_report 02:57:33 INFO - PROCESS | 3831 | __startTimestamp1484477853525__endTimestamp 02:57:33 INFO - PROCESS | 3831 | 02:57:33 INFO - PROCESS | 3831 | ------- Summary: start ------- 02:57:33 INFO - PROCESS | 3831 | Number of tests: 14 02:57:33 INFO - PROCESS | 3831 | 02:57:33 INFO - PROCESS | 3831 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:3.75 (3.4%) stddev-sans-first:0.88 02:57:33 INFO - PROCESS | 3831 | Values: 99.0 111.0 110.0 109.0 112.0 111.0 110.0 111.0 111.0 110.0 02:57:33 INFO - PROCESS | 3831 | 02:57:33 INFO - PROCESS | 3831 | [#1] audio-beat-detection Cycles:10 Average:129.90 Median:122.50 stddev:16.99 (13.9%) stddev-sans-first:15.41 02:57:33 INFO - PROCESS | 3831 | Values: 155.0 117.0 118.0 153.0 122.0 121.0 117.0 123.0 155.0 118.0 02:57:33 INFO - PROCESS | 3831 | 02:57:33 INFO - PROCESS | 3831 | [#2] audio-dft Cycles:10 Average:160.80 Median:160.00 stddev:1.87 (1.2%) stddev-sans-first:1.96 02:57:33 INFO - PROCESS | 3831 | Values: 160.0 160.0 162.0 164.0 164.0 160.0 160.0 160.0 159.0 159.0 02:57:33 INFO - PROCESS | 3831 | 02:57:33 INFO - PROCESS | 3831 | [#3] audio-fft Cycles:10 Average:80.40 Median:74.50 stddev:13.16 (17.7%) stddev-sans-first:13.86 02:57:33 INFO - PROCESS | 3831 | Values: 76.0 75.0 74.0 113.0 74.0 74.0 75.0 74.0 95.0 74.0 02:57:33 INFO - PROCESS | 3831 | 02:57:33 INFO - PROCESS | 3831 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:82.00 stddev:12.99 (15.8%) stddev-sans-first:13.49 02:57:33 INFO - PROCESS | 3831 | Values: 82.0 81.0 117.0 82.0 83.0 82.0 105.0 81.0 82.0 100.0 02:57:33 INFO - PROCESS | 3831 | 02:57:33 INFO - PROCESS | 3831 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:57:33 INFO - PROCESS | 3831 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 02:57:33 INFO - PROCESS | 3831 | 02:57:33 INFO - PROCESS | 3831 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 02:57:33 INFO - PROCESS | 3831 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 02:57:33 INFO - PROCESS | 3831 | 02:57:33 INFO - PROCESS | 3831 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.67 (0.8%) stddev-sans-first:0.53 02:57:33 INFO - PROCESS | 3831 | Values: 86.0 84.0 84.0 84.0 85.0 85.0 84.0 85.0 85.0 85.0 02:57:33 INFO - PROCESS | 3831 | 02:57:33 INFO - PROCESS | 3831 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:50.00 stddev:3.54 (7.1%) stddev-sans-first:3.75 02:57:33 INFO - PROCESS | 3831 | Values: 51.0 47.0 50.0 49.0 49.0 50.0 51.0 49.0 49.0 60.0 02:57:33 INFO - PROCESS | 3831 | 02:57:33 INFO - PROCESS | 3831 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:1.55 (2.6%) stddev-sans-first:1.58 02:57:33 INFO - PROCESS | 3831 | Values: 58.0 60.0 59.0 58.0 63.0 60.0 58.0 59.0 59.0 58.0 02:57:33 INFO - PROCESS | 3831 | 02:57:33 INFO - PROCESS | 3831 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:75.50 stddev:2.23 (3.0%) stddev-sans-first:2.33 02:57:33 INFO - PROCESS | 3831 | Values: 75.0 75.0 75.0 75.0 74.0 77.0 76.0 80.0 74.0 80.0 02:57:33 INFO - PROCESS | 3831 | 02:57:33 INFO - PROCESS | 3831 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:121.00 stddev:13.22 (10.9%) stddev-sans-first:13.94 02:57:33 INFO - PROCESS | 3831 | Values: 122.0 120.0 119.0 121.0 119.0 121.0 121.0 139.0 160.0 121.0 02:57:33 INFO - PROCESS | 3831 | 02:57:33 INFO - PROCESS | 3831 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.20 Median:151.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 02:57:33 INFO - PROCESS | 3831 | Values: 151.0 153.0 151.0 152.0 151.0 151.0 151.0 150.0 151.0 151.0 02:57:33 INFO - PROCESS | 3831 | 02:57:33 INFO - PROCESS | 3831 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.10 (1.8%) stddev-sans-first:1.17 02:57:33 INFO - PROCESS | 3831 | Values: 62.0 63.0 61.0 61.0 64.0 61.0 63.0 61.0 61.0 62.0 02:57:33 INFO - PROCESS | 3831 | -------- Summary: end -------- 02:57:33 INFO - PROCESS | 3831 | 02:57:34 INFO - TEST-INFO | 3831: exit 0 02:57:34 INFO - TEST-OK | kraken | took 59705ms 02:57:34 INFO - SUITE-END | took 1176s 02:57:34 INFO - Completed test suite (00:19:36) 02:57:34 INFO - javascript benchmark 02:57:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3212.8072315661057, 3254.040058182837, 3267.705906468417, 3275.13208999615, 3288.7862288951214, 5585.636933599319, 5658.91511627326, 5670.036093864042, 5672.744726487308, 5674.574406919477, 5550.111982082867, 5599.8600034999145, 5611.691356975365, 5612.607117501766, 5627.296587926509, 5072.79708811648, 5096.643234973553, 5119.360079990001, 5121.385433747937, 5156.510131537517, 4929.285253638221, 4955.08330958772, 5148.150555158394, 5154.536091751742, 5192.844214673566, 5019.0463811875625, 5067.417247016603, 5074.31496747938, 5078.263651770491, 5084.084864724348, 5094.6433749637545, 5144.511271429208, 5154.92267615986, 5185.351831021104, 5186.92219616706, 5104.387473503203, 5196.090684130299, 5200.947990520084, 5213.556847667915, 5247.212918062283, 5379.085555455582, 5417.945820541783, 5653.547716182696, 5658.547316214693, 5745.885082298372, 5896.439838215363, 5935.614185077956, 5938.346781853993, 5985.8802823943715, 6007.549433792483, 6039.4262545058145, 6048.606840555394, 6059.0608455689, 6062.787802426894, 6065.423784740443, 5408.675479471244, 5468.070428027245, 5621.718914054321, 5637.915431268534, 5647.181158731961, 6039.909401358983, 6075.939240607538, 6086.05666121743, 6156.6921653917125, 6157.291911430153, 5902.966980778432, 5903.822885313448, 5905.586608937333, 5906.911396329058, 5934.673592952429, 5680.204771332017, 5979.760809567569, 5994.610350327215, 5998.980173370537, 6006.729697163638, 5783.248177736951, 5921.822345329647, 5967.940320596738, 5983.730732117066, 6053.576249662481, 6068.4538391544975, 6069.605475644069, 6077.8480537986015, 6087.908681369783, 6101.84745381369, 4645.976770116128, 4653.511381304982, 4653.7207767534055, 4669.603083737852, 4678.742669153229, 4000.299947509174, 4039.5758445362812, 4043.4137050127565, 4103.076807718239, 4156.584341565819, 5663.263775709132, 5688.374278829326, 5706.343770466449, 5713.457221563945, 5729.1119876419225, 5961.493273071751, 6071.271447426248, 6077.4226448487325, 6082.9695851520455, 6103.633781973096, 5409.459054094637, 5459.563234941195, 5607.607467477319, 5687.573431992617, 5693.516051135617, 5214.217867319857, 5260.210968354778, 5276.630635855453, 5289.471052894757, 5294.391145018295, 6176.289726681399, 6181.258249010058, 6181.84545386369, 6189.876202476015, 6191.442770150708, 5814.273215848019, 5847.473727364558, 6074.1799857020505, 6078.118672792509, 6086.969565152323, 6034.939650603614, 6057.545684073624, 6073.180120683651, 6169.444749972345, 6179.69101544912, 5902.232709747877, 5914.142449344735, 5923.496502797138, 5927.40725927421, 5931.911021334769, 5735.426457354231, 5959.851003724942, 6013.819585412444, 6043.425874541911, 6047.909281360695, 5638.6898720569125, 5821.94178058214, 5838.912416313674, 5860.648361098348, 5957.046872500379, 5861.1501332307425, 5893.263342082239, 5895.882082358415, 5908.734106965111, 5920.3783602722815, 5626.662400255834, 5877.94122058774, 5899.46904778572, 5902.852428689317, 5906.0, 5754.108113242454, 5849.210356601804, 5864.266966629171, 5894.616849904743, 5995.850103747267, 5776.277965254343, 5824.0, 5831.096180092092, 5842.065269556851, 5844.94155058444], "value": 5532.683160705281, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.9378465261148, 594.9583529152958, 629.4460874430501, 656.8522082531427, 672.1228796420676, 33869.66130338696, 43576.0, 44688.77655611718, 44736.55263447364, 44785.55214447855, 47320.290195647096, 47708.284375734394, 47740.76129619347, 47825.0, 47838.0, 8369.623366948472, 8551.144885511461, 8802.075782042873, 8937.150970657776, 8941.64233430662, 10196.0, 10440.94779526105, 10443.68668939933, 10708.0, 10716.78566428671, 10894.237403381767, 10959.890401095967, 10962.0, 10963.56145754169, 10968.561257549689, 10772.946135269312, 10837.512311945902, 10839.729006774854, 10842.295250808673, 10842.566297348096, 10707.411092389915, 10764.73088172794, 10774.946125269324, 10775.515101820436, 10779.514921828537, 43699.781501092606, 43805.0, 43901.341479877825, 43975.78012109951, 44016.77991610021, 3562.5724913010604, 3752.399616061417, 3868.7678739275734, 3871.6515513603913, 4150.003999040239, 32737.672623273702, 32890.0, 32917.341653167045, 33026.504602430985, 33224.83387583047, 4386.736795792231, 4440.866773996785, 4470.41884555009, 4473.776311184428, 4484.0, 349182.0, 353344.0, 354216.0, 354303.99999999744, 355240.0, 66077.0, 66498.0, 66568.66715666391, 66664.0, 66838.0, 39173.0, 40461.0, 40507.79746101251, 70030.64984675044, 70273.0, 18542.629147416978, 18828.24687012504, 18855.90572047131, 18882.811171888105, 18891.244350225836, 12063.75872482563, 12426.813597796041, 12445.315507646985, 12776.872231277754, 12816.166949148275, 19482.30238156819, 21327.36017919465, 21390.465238369165, 21405.0, 21471.0, 7350.816229594196, 7581.3176814087, 7603.353714934182, 7707.4604777666145, 7851.528908265523, 969.3892847506168, 1049.6641074855972, 1105.8396532502902, 1132.4677401621389, 1232.910217181886, 31699.366012679617, 34434.655653443144, 34454.655453445645, 34496.310073798384, 34939.65060349364, 1092.3609688332415, 1125.2629527659396, 1142.7771584540935, 1158.0, 1235.1477480538579, 15628.687426251412, 17822.0, 18395.0, 18855.15151818144, 19211.807881921282, 510702.0, 753129.0, 758242.0, 758420.0, 759564.0, 65567.34432655708, 66102.66948665322, 66120.66939665271, 66335.66832165905, 66362.33637663562, 1356.1727346318737, 1404.8735613794604, 1423.3418067950722, 1452.4117732318427, 1489.6499322659167, 32278.515822262216, 36234.456483152244, 36423.0, 37095.62904370922, 37536.249275014896, 60647.0, 61292.38707612867, 61406.69296653488, 61442.69278653578, 61466.0, 455398.0, 457143.0, 457392.0, 457697.0, 460468.0, 30967.69032309648, 31766.364672706877, 32023.839880801377, 32070.839645802556, 32073.198170045936, 49633.0, 49875.25187122269, 50042.49957500524, 50367.0, 50506.74746626243, 42536.361954570086, 42603.57396425996, 43100.0, 43708.0, 44246.557534425534, 41906.58093419027, 41917.79041104775, 42152.0, 43233.0, 43446.56553434425, 42511.57488425076, 43047.78476107599, 43247.0, 43496.56503435052, 43742.0, 34131.65868341384, 37189.6281037197, 37926.810365948, 38415.6158438412, 39257.0, 29269.41461170722, 29492.0, 29539.261518462212, 29547.40905181927, 29594.0], "value": 21667.513648998894, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.86438610872335, 425.14121474621265, 425.3470922134524, 428.1266216917488, 450.9661775366846, 15400.537983860488, 19094.809051909477, 20085.698714519276, 21292.4676883078, 21475.67786483204, 19593.314234001813, 20505.897470512664, 20716.48208794781, 20782.16871325149, 20962.371128866158, 5697.316322041361, 5915.024021036524, 5919.260092488439, 5919.674417907014, 5924.37794031627, 5634.746436410351, 5870.794522191724, 5898.0, 5966.134910437984, 5973.074173503114, 5770.971145144268, 5955.731992060346, 5973.313068997078, 5975.0, 5975.0439929611275, 5957.255343082114, 6110.786122485736, 6113.541484388688, 6125.081237814341, 6136.662483563425, 5837.744884849735, 5895.41045895407, 5928.784599157162, 6042.788502402394, 6066.181065556182, 14538.491152809602, 14704.117752934751, 14955.850441495555, 15099.169545674984, 15205.239738013166, 2363.2319496163814, 2464.507098580273, 2514.270861450177, 2581.1611226351324, 2583.573710337792, 10316.174706023576, 10799.622013229578, 11086.61196858106, 11348.09215262777, 11455.942720286428, 1981.4550998475534, 2015.858889877709, 2036.7352244208307, 2060.8351331893414, 2068.9482762930897, 78021.21978780253, 80337.59831200865, 80944.59527702324, 93241.53379233128, 97764.51117744365, 10737.731556711145, 11598.0, 11890.346030968207, 11941.70145746346, 11975.161738678209, 15246.847531524543, 16009.919950400174, 16097.758533622005, 16112.75830862538, 16696.83303166953, 7106.253843346478, 8877.112288771072, 9082.003918275937, 9087.045860184717, 9236.769080773034, 8408.453450525696, 8544.40189186751, 8729.781755456037, 8751.431156974777, 8946.150115738994, 5051.545360917535, 5071.188609822484, 5130.333056702605, 5137.2037334213255, 5143.871403214949, 2059.6704527275565, 2083.874967501955, 2095.402810199086, 2099.8240985048114, 2149.9032543535577, 962.3456049886145, 962.870012548311, 980.9362391444533, 989.1147423056468, 1045.451138152476, 20056.498587535138, 20441.897790510953, 20524.0, 20562.69155962662, 20713.585728285652, 1031.3811712972306, 1033.8707661542308, 1047.3401756893109, 1052.3528030261486, 1079.4279032112836, 10622.93770622947, 11795.469203885847, 11894.16740828151, 11990.820137697941, 11993.88006119945, 377203.0, 461651.0, 466817.0, 480225.0, 481415.0, 95247.0, 96299.0, 99197.50401248092, 100110.49944750375, 101133.0, 1013.6249587652468, 1023.81059503992, 1032.607609108534, 1035.321864178964, 1035.8394448860288, 17887.37394191197, 17921.19354629019, 18104.818951810314, 18401.171947262672, 18862.0, 44313.0, 44521.33218001668, 44550.55449445464, 45209.54790452185, 46350.30474542817, 61624.38375616366, 62315.0, 62753.0, 65276.0, 65395.0, 8838.734837954871, 8942.73171804847, 9006.54967251648, 9019.774505637411, 9316.813663726552, 10116.0, 12525.498980040697, 12990.220586764824, 13296.734065318833, 14135.434582616992, 11604.6518604442, 11812.409379530816, 12175.452104655134, 12249.816252756038, 12393.194442361219, 11591.826122608, 11614.419279035845, 11638.592649257236, 11991.460384282902, 12516.687082823002, 11803.468843901874, 12014.219075760047, 12114.939425302817, 12173.39133043362, 12218.816717749063, 9198.586063627019, 9207.447553146832, 9211.723648290563, 9288.814223715623, 9357.625694972125, 10194.43930583825, 11740.530378784753, 11984.40077996114, 12175.39123043862, 12189.878101218874], "value": 9521.262508066038, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1369.0827145812318, 1481.2889812889812, 1512.009633689933, 1685.7892763404575, 1828.890266584006, 7788.260115289053, 8430.452020618655, 8686.261667758232, 8699.39104262702, 8927.508987005713, 8751.95624021879, 8821.161989610993, 8823.338249631272, 8824.0, 8829.117088291168, 2497.962530562043, 2522.3567990162483, 2524.936876578091, 2528.5954247320433, 2528.696556413224, 2468.6790717206736, 2555.642210090589, 2558.9488210235786, 2564.4742827720274, 2566.2044766122467, 2481.0695989004125, 2482.553140434721, 2513.5726926422553, 2515.4591762771092, 2516.3331717094893, 2306.3542208181734, 2343.250159948817, 2361.551305252005, 2444.107900616262, 2448.033026954361, 2410.072122232953, 2455.4229756007326, 2465.174166654173, 2488.962665560018, 2491.950160996788, 8494.78763030923, 8804.339674524435, 8874.0, 8879.600417981143, 8883.955580222058, 5452.809151679712, 5667.631603945731, 5667.744951477193, 5670.914936275959, 5675.063614503602, 3500.3349363621087, 3641.6540428659237, 3646.781193128421, 3698.6301369863068, 3713.740038197327, 1185.478389508622, 1188.597455003096, 1232.4577186038114, 1235.1786062268582, 1240.962771116868, 12520.186187897758, 12695.55565555201, 12696.746065078647, 12707.364631768467, 12712.110152289344, 4489.842855500042, 4681.531846815359, 4749.311349854252, 4754.524547545287, 4787.042591481718, 9694.175995040501, 9755.170810481188, 9763.804723905625, 9777.853332200022, 9782.75543111428, 5515.834524964257, 5523.254360661259, 5524.1989911462615, 5525.917111243334, 5527.060399731975, 4365.410669559632, 4443.955560444419, 4949.925751113737, 4988.501149884983, 5140.3831540215415, 3940.763554186758, 3986.8405263789705, 4048.716589838683, 4081.8979525511504, 4091.3453847384276, 1243.490169030693, 1257.8113283007622, 1264.051961029228, 1266.6073517209695, 1269.2321145706899, 997.0976266478848, 999.0, 1008.8537162111453, 1014.91373233276, 1023.2019025160387, 6052.182955300978, 6178.104174894705, 6344.111824344595, 6359.7456101755415, 6581.934180658228, 477.68472807947285, 478.3757196858064, 486.2463182067781, 488.62620095626875, 508.22241969786285, 4437.711548749321, 4445.155420470101, 4462.152191083684, 4482.0, 4507.639388848885, 10644.840327395095, 10968.451577421098, 11067.169962252863, 11082.390468524309, 11084.279521831055, 11032.227744057838, 11033.779324413626, 11036.282641628268, 11043.392613406178, 11053.668389948314, 7898.2891539761695, 8194.959025204837, 8203.220694034057, 8370.455920365157, 8370.707025254209, 6201.875962480815, 6244.219472565929, 6423.261324947691, 6432.625814446222, 6519.706613202512, 9878.209743220668, 9882.160016398399, 9937.801243975224, 10037.849432258376, 10314.0, 10233.795324093626, 10282.640107596199, 10328.483575821028, 10334.328268662814, 10357.378557286587, 7484.176740558643, 7678.961605191938, 7774.378049755893, 7870.645820938186, 7921.485103468256, 8458.28104611115, 8509.276711479593, 8561.657533698832, 8571.528565928933, 8582.0, 7497.662605182671, 7608.467407281437, 7630.885536716843, 7682.154962954182, 7752.108507521707, 7442.367398771165, 7460.626968651654, 7506.13679426851, 7575.393968482398, 7776.7278145264645, 6836.350546698056, 6889.552179108542, 6931.202911665223, 6931.584104953719, 7055.365017148276, 5322.467753224647, 5452.236686863763, 5511.255980442589, 5547.833564993057, 5602.775888964559, 5471.781128754806, 5490.450954904637, 5497.725113744376, 5622.100463925753, 5692.686902220252], "value": 4683.242967659749, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.22560817418025, 364.8595290813036, 365.20932181826345, 368.0834721543356, 374.9456328832318, 5353.170258609917, 5396.866658001814, 5400.108982017962, 5407.729613519318, 5425.674459532431, 5305.124654432014, 5322.068637988346, 5326.440723724002, 5333.599980001506, 5339.813106541272, 4129.1328820947565, 4171.895702607444, 4210.031692710679, 4211.178820130076, 4222.986483244014, 4198.391233271173, 4205.327147656376, 4205.558416366283, 4207.579242075783, 4222.683298752606, 4177.582241775828, 4181.393697913801, 4193.706440549163, 4194.538600753915, 4194.937075943863, 4096.508418989725, 4164.937525937114, 4172.4993000840095, 4194.769287689176, 4194.895127621803, 3709.2952339055764, 3710.6845918096724, 3712.554493460775, 3716.1267102230954, 3716.535433070866, 5195.064888320101, 5205.141151709963, 5216.295800067019, 5226.477352264781, 5230.424653288173, 4650.0, 4655.439508270471, 4712.599429048535, 4749.525047495257, 4759.286107083931, 5493.626593351662, 5514.476124768141, 5528.474794894479, 5530.253415788898, 5541.196526503634, 4053.067794407273, 4053.8581149659917, 4053.97973010136, 4063.553009168989, 4065.9390109148385, 5575.944240557583, 5719.456651618089, 5723.513501352431, 5765.711714414305, 5797.246357973437, 4125.1749650069505, 4130.339145736668, 4142.357934520154, 4156.58434156588, 4158.91682166355, 4184.267753143188, 4215.924939140499, 4216.7259128156575, 4217.768022758716, 4217.936730949038, 4640.5359464054, 4761.309610106515, 4761.500042495557, 4766.523347665275, 4781.928271075936, 5562.749676264497, 5564.888702225933, 5584.329880414376, 5598.776048957996, 5600.215969764236, 1385.778275475919, 1397.7071209131716, 1397.9790303145462, 1402.7194561087824, 1407.3596513586294, 929.3726734454216, 979.0747743382577, 983.4541829284673, 989.5453683085852, 993.9353941993892, 5176.378834539879, 5183.015227106837, 5194.844154675366, 5202.895942081137, 5203.115470370046, 5498.5876059295715, 5509.889802204014, 5521.2270282160525, 5529.30883639545, 5533.3083364579425, 4945.7774400152075, 5181.248718935809, 5182.792688292501, 5190.558802501754, 5248.160294352885, 2884.4952133376996, 2911.344947386821, 2913.810602310843, 2914.533674612052, 2928.604638373835, 5590.664560126405, 5616.146671598362, 5642.774289028475, 5644.081012455785, 5656.91514627281, 5362.2224777407055, 5560.7219639017885, 5575.275214222125, 5580.632744977506, 5588.524975377057, 5719.628224165416, 5731.398203188689, 5821.27234095738, 5842.0, 5847.853803654943, 5675.7445914933105, 5734.99637563433, 5739.0243658578975, 5758.481736643722, 5766.163906233489, 5531.0873705839695, 5635.211070450058, 5645.1532270159805, 5645.532161638086, 5677.858053548694, 5842.269716285465, 5843.590948633555, 5848.941510584839, 5848.970755146197, 5861.794837180678, 4101.589841015994, 4110.725675040747, 4120.876373708794, 4121.835126595022, 4134.937975930424, 5548.946889650855, 5664.971675141598, 5739.2252045973255, 5743.56923230751, 5765.279340082489, 5576.944230557642, 5588.91016251827, 5590.888182236251, 5597.776088956559, 5620.325560932714, 5337.199420087018, 5548.361938377138, 5566.944330556643, 5608.130739735348, 5610.579206559442, 5528.7235638218735, 5570.888582228252, 5571.303587051619, 5579.776808927598, 5591.9720401397735, 5634.380218175916, 5637.267155269788, 5641.238432811518, 5647.858803529944, 5654.575906807088, 5259.39516955555, 5486.259354987025, 5515.283013208417, 5517.806876759294, 5524.281843360337], "value": 4254.137570815669, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.918129415117, 757.469771160188, 800.427694198648, 815.3192084609351, 839.1608391608391, 13749.725005499884, 14151.221682807442, 14441.638959026004, 14462.855371446283, 14462.927685361572, 12476.875231247684, 12531.2481251125, 12556.309402982832, 12557.121001529897, 12564.0, 695.5166159519149, 725.5066554742799, 830.983380332393, 862.3015357560396, 874.2350443362059, 866.6966561703385, 867.5878957495171, 867.8090820019618, 868.5743985447117, 868.9956550217272, 734.8016035670365, 918.8346097702411, 922.2760133295365, 922.349743430883, 922.423485321674, 765.9272369124924, 879.5865943006777, 910.2626872233479, 914.6067191107821, 917.0462718772469, 673.1854456108115, 673.9224989126216, 675.7060678604822, 675.8715843989626, 675.8952362383839, 13336.0, 13762.65593360164, 13844.93077534616, 13854.930725346308, 13901.16593004423, 13370.197788132646, 13793.517226897111, 13824.930875345559, 13971.161730296113, 14032.1580705157, 12195.14633975622, 12323.383830808423, 12354.840789924057, 12363.781253112842, 12434.81347779784, 4321.675874309408, 4347.739135651871, 4369.868903932856, 4425.889352766175, 4447.510773814878, 63357.683211583644, 64119.67940160316, 64177.03734443987, 65380.3461965379, 65564.0, 10770.869058748875, 10796.730081748019, 10829.783404331869, 11043.116550675926, 11045.558177672803, 20578.176872925214, 20634.79365206359, 20649.483762906046, 20672.58654826895, 20681.482962925747, 8091.635876385577, 8093.595320233965, 8362.54006029662, 8400.369972252105, 8419.705310314232, 4359.891002724894, 4423.181711383404, 4480.103979204172, 4534.954650453519, 4686.203345431285, 3514.1741690702665, 3670.541182352206, 3683.9631603684156, 3684.447332900033, 3686.889393318205, 649.1042361541043, 649.8635286589774, 652.6084349390422, 663.6582160187507, 675.3988949834651, 718.1956209045902, 751.4289140253337, 773.9187385324573, 774.4772278711847, 786.8544319300947, 9253.444793312423, 9415.435073895589, 9444.527773611291, 9721.416714997124, 9734.75663108428, 677.7526202935992, 756.6897571995455, 763.0957315581054, 775.4726785785607, 775.9806004849924, 4673.602743766818, 4873.269009648581, 4891.877703057452, 4903.8528844134735, 4938.703677779345, 82239.0, 86678.0, 86905.5654721735, 89999.0, 90384.5480772592, 50417.99164016699, 66582.66708666425, 66773.0, 67163.0, 78748.60625696834, 65768.99999999904, 66349.66825165843, 66546.33453665402, 68621.31378686149, 68792.0, 9080.772980675536, 9207.76980575491, 9555.426674399558, 9606.711798646053, 9805.754856128653, 46613.06773864572, 47285.763571181924, 47346.28980565363, 48236.0, 49423.25865112098, 62536.37463625306, 63323.36676633175, 63360.68319658372, 63638.68180659067, 65919.0, 12265.57070502528, 12311.0, 12350.135490515937, 12431.378431078228, 12768.233905965672, 13650.112742671694, 13728.65678358049, 13730.588082357544, 13814.516491922734, 14562.927185364006, 12873.871261287642, 12933.870661293644, 13596.796048059485, 13654.86345136536, 13954.651133721738, 12343.629691109281, 12400.875991240333, 12702.237865728086, 13497.86502134966, 13509.662258443617, 12525.686857828627, 12780.297083660487, 12992.935035324763, 13021.739565208833, 13427.462901483832, 10962.0, 11074.446277686244, 11080.0, 11162.776744465227, 11658.18392712536, 10931.289466184673, 11200.0, 11470.197086203885, 11546.307221566733, 11685.474153662935], "value": 7259.435814119322, "unit": "score"}], "name": "dromaeo_css", "value": 7406.697031559576, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 111.0, 110.0, 109.0, 112.0, 111.0, 110.0, 111.0, 111.0, 110.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 117.0, 118.0, 153.0, 122.0, 121.0, 117.0, 123.0, 155.0, 118.0], "value": 129.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 164.0, 164.0, 160.0, 160.0, 160.0, 159.0, 159.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 113.0, 74.0, 74.0, 75.0, 74.0, 95.0, 74.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 117.0, 82.0, 83.0, 82.0, 105.0, 81.0, 82.0, 100.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 84.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": [51.0, 47.0, 50.0, 49.0, 49.0, 50.0, 51.0, 49.0, 49.0, 60.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 59.0, 58.0, 63.0, 60.0, 58.0, 59.0, 59.0, 58.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 75.0, 74.0, 77.0, 76.0, 80.0, 74.0, 80.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 120.0, 119.0, 121.0, 119.0, 121.0, 121.0, 139.0, 160.0, 121.0], "value": 126.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 153.0, 151.0, 152.0, 151.0, 151.0, 151.0, 150.0, 151.0, 151.0], "value": 151.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 61.0, 64.0, 61.0, 63.0, 61.0, 61.0, 62.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1442.9, "alertThreshold": 2.0}]} 02:57:34 INFO - Return code: 0 02:57:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:57:34 INFO - # TBPL SUCCESS # 02:57:34 INFO - Running post-action listener: _resource_record_post_action 02:57:34 INFO - [mozharness: 2017-01-15 10:57:34.842836Z] Finished run-tests step (success) 02:57:34 INFO - Running post-run listener: _resource_record_post_run 02:57:34 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 9691136; Write bytes: 376864768; Read time: 1996; Write time: 314724 02:57:34 INFO - TinderboxPrint: CPU usage
13.0% 02:57:34 INFO - TinderboxPrint: I/O read bytes / time
9,691,136 / 1,996 02:57:34 INFO - TinderboxPrint: I/O write bytes / time
376,864,768 / 314,724 02:57:34 INFO - TinderboxPrint: CPU idle
8,286.4 (87.0%) 02:57:34 INFO - TinderboxPrint: CPU user
1,189.2 (12.5%) 02:57:34 INFO - TinderboxPrint: Swap in / out
0 / 0 02:57:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 59129856; Read time: 36; Write time: 46060 02:57:34 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 7520256; Write bytes: 254296064; Read time: 1496; Write time: 172020 02:57:35 INFO - Running post-run listener: _upload_blobber_files 02:57:35 INFO - Blob upload gear active. 02:57:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:57:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:57:35 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'] 02:57:35 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 02:57:35 INFO - (blobuploader) - INFO - Open directory for files ... 02:57:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:57:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:57:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:57:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:57:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:57:39 INFO - (blobuploader) - INFO - Done attempting. 02:57:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:57:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:57:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:57:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:57:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:57:40 INFO - (blobuploader) - INFO - Done attempting. 02:57:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:57:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:57:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:57:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:57:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:57:40 INFO - (blobuploader) - INFO - Done attempting. 02:57:40 INFO - (blobuploader) - INFO - Iteration through files over. 02:57:40 INFO - Return code: 0 02:57:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:57:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:57:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0cd2fa3815211c179a34949594e9e4baef4c57638cc9d7e2711cc2ebb04573d3aaa0ed321a01e3f0cc29d1b51b0e2083c55b92869442842d9179079c869572e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f733b560ba711e3c257bbf3e60b6319d37fbfc214109e6ba5eb4d9b3d9ab46a25b02e9df7ed2d2996815f571d9eef4265ba362ac01f8902445e65f70f4a2fb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1689747a39e3ccd34a5eb83e94472b4f37f48782538ff863a71015c46872ceec3007c431a3594a67c402387b6d30e25c2e38e87fd9cdb010d3f52e3318fb31f2"} 02:57:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:57:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:57:40 INFO - Contents: 02:57:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0cd2fa3815211c179a34949594e9e4baef4c57638cc9d7e2711cc2ebb04573d3aaa0ed321a01e3f0cc29d1b51b0e2083c55b92869442842d9179079c869572e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f733b560ba711e3c257bbf3e60b6319d37fbfc214109e6ba5eb4d9b3d9ab46a25b02e9df7ed2d2996815f571d9eef4265ba362ac01f8902445e65f70f4a2fb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1689747a39e3ccd34a5eb83e94472b4f37f48782538ff863a71015c46872ceec3007c431a3594a67c402387b6d30e25c2e38e87fd9cdb010d3f52e3318fb31f2"} 02:57:40 INFO - Running post-run listener: copy_logs_to_upload_dir 02:57:40 INFO - Copying logs to upload dir... 02:57:40 INFO - mkdir: /builds/slave/test/build/upload/logs 02:57:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.269523 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-01-15 02:57:40.723883) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-15 02:57:40.728704) ========= 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=1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632 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/0cd2fa3815211c179a34949594e9e4baef4c57638cc9d7e2711cc2ebb04573d3aaa0ed321a01e3f0cc29d1b51b0e2083c55b92869442842d9179079c869572e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f733b560ba711e3c257bbf3e60b6319d37fbfc214109e6ba5eb4d9b3d9ab46a25b02e9df7ed2d2996815f571d9eef4265ba362ac01f8902445e65f70f4a2fb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1689747a39e3ccd34a5eb83e94472b4f37f48782538ff863a71015c46872ceec3007c431a3594a67c402387b6d30e25c2e38e87fd9cdb010d3f52e3318fb31f2"} build_url:https://queue.taskcluster.net/v1/task/cupKHqifQJ6KBYAhzVElNA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011402 build_url: 'https://queue.taskcluster.net/v1/task/cupKHqifQJ6KBYAhzVElNA/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/0cd2fa3815211c179a34949594e9e4baef4c57638cc9d7e2711cc2ebb04573d3aaa0ed321a01e3f0cc29d1b51b0e2083c55b92869442842d9179079c869572e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f733b560ba711e3c257bbf3e60b6319d37fbfc214109e6ba5eb4d9b3d9ab46a25b02e9df7ed2d2996815f571d9eef4265ba362ac01f8902445e65f70f4a2fb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1689747a39e3ccd34a5eb83e94472b4f37f48782538ff863a71015c46872ceec3007c431a3594a67c402387b6d30e25c2e38e87fd9cdb010d3f52e3318fb31f2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-15 02:57:40.761270) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 02:57:40.761640) ========= 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=1f5564757af27664ca02d71f000001b0-1484465914.311332-910358632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 02:57:40.840404) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-15 02:57:40.840762) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-15 02:57:40.841124) ========= ========= Total master_lag: 0.21 =========