builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-079 starttime: 1487196295.97 results: success (0) buildid: 20170215120914 builduid: 152312ca3e794437a3d954f93948111a revision: c79b61700177693e486bd968dfd51f38c8781f0a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 14:04:55.972750) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 14:04:55.973349) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 14:04:55.973668) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 14:04:55.986079) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 14:04:55.986391) ========= 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=1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-15 14:04:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.2M=0.001s 2017-02-15 14:04:56 (20.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108477 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 14:04:56.106509) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 14:04:56.106989) ========= 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=1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022654 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 14:04:56.157339) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-15 14:04:56.157714) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c79b61700177693e486bd968dfd51f38c8781f0a --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-beta --rev c79b61700177693e486bd968dfd51f38c8781f0a --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=1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-15 14:04:56,373 truncating revision to first 12 chars 2017-02-15 14:04:56,373 Setting DEBUG logging. 2017-02-15 14:04:56,373 attempt 1/10 2017-02-15 14:04:56,374 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c79b61700177?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-15 14:04:57,738 unpacking tar archive at: mozilla-beta-c79b61700177/testing/mozharness/ program finished with exit code 0 elapsedTime=1.758112 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-15 14:04:57.929240) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 14:04:57.929558) ========= script_repo_revision: c79b61700177693e486bd968dfd51f38c8781f0a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 14:04:57.929947) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 14:04:57.930225) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 14:04:57.938361) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-02-15 14:04:57.938639) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:04:58 INFO - MultiFileLogger online at 20170215 14:04:58 in /builds/slave/test 14:04:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:04:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:04:58 INFO - {'append_to_log': False, 14:04:58 INFO - 'base_work_dir': '/builds/slave/test', 14:04:58 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:04:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:04:58 INFO - 'branch': 'Mozilla-Beta', 14:04:58 INFO - 'buildbot_json_path': 'buildprops.json', 14:04:58 INFO - 'config_files': ('talos/linux_config.py',), 14:04:58 INFO - 'default_actions': ('clobber', 14:04:58 INFO - 'read-buildbot-config', 14:04:58 INFO - 'download-and-extract', 14:04:58 INFO - 'populate-webroot', 14:04:58 INFO - 'create-virtualenv', 14:04:58 INFO - 'install', 14:04:58 INFO - 'run-tests'), 14:04:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:04:58 INFO - 'download_minidump_stackwalk': True, 14:04:58 INFO - 'download_symbols': 'ondemand', 14:04:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:04:58 INFO - 'tooltool.py': '/tools/tooltool.py', 14:04:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:04:58 INFO - '/tools/misc-python/virtualenv.py')}, 14:04:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:04:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:04:58 INFO - 'installer_path': 'installer.exe', 14:04:58 INFO - 'log_level': 'info', 14:04:58 INFO - 'log_name': 'talos', 14:04:58 INFO - 'log_to_console': True, 14:04:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:04:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:04:58 INFO - 'opt_config_files': (), 14:04:58 INFO - 'pip_index': False, 14:04:58 INFO - 'sps_profile': False, 14:04:58 INFO - 'sps_profile_interval': 0, 14:04:58 INFO - 'suite': 'dromaeojs', 14:04:58 INFO - 'system_bits': '32', 14:04:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:04:58 INFO - 'title': 'talos-linux64-ix-079', 14:04:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:04:58 INFO - 'use_talos_json': True, 14:04:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:04:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:04:58 INFO - 'work_dir': 'build'} 14:04:58 INFO - [mozharness: 2017-02-15 22:04:58.250381Z] Running clobber step. 14:04:58 INFO - Running pre-action listener: _resource_record_pre_action 14:04:58 INFO - Running main action method: clobber 14:04:58 INFO - rmtree: /builds/slave/test/build 14:04:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:04:59 INFO - Running post-action listener: _resource_record_post_action 14:04:59 INFO - [mozharness: 2017-02-15 22:04:59.685106Z] Finished clobber step (success) 14:04:59 INFO - [mozharness: 2017-02-15 22:04:59.685205Z] Running read-buildbot-config step. 14:04:59 INFO - Running pre-action listener: _resource_record_pre_action 14:04:59 INFO - Running main action method: read_buildbot_config 14:04:59 INFO - Using buildbot properties: 14:04:59 INFO - { 14:04:59 INFO - "project": "", 14:04:59 INFO - "product": "firefox", 14:04:59 INFO - "script_repo_revision": "production", 14:04:59 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 14:04:59 INFO - "repository": "", 14:04:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 14:04:59 INFO - "buildid": "20170215120914", 14:04:59 INFO - "pgo_build": "True", 14:04:59 INFO - "basedir": "/builds/slave/test", 14:04:59 INFO - "buildnumber": 18, 14:04:59 INFO - "slavename": "talos-linux64-ix-079", 14:04:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:04:59 INFO - "platform": "ubuntu64_hw", 14:04:59 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:04:59 INFO - "branch": "mozilla-beta", 14:04:59 INFO - "repo_path": "releases/mozilla-beta", 14:04:59 INFO - "revision": "c79b61700177693e486bd968dfd51f38c8781f0a", 14:04:59 INFO - "stage_platform": "linux64-pgo", 14:04:59 INFO - "builduid": "152312ca3e794437a3d954f93948111a", 14:04:59 INFO - "slavebuilddir": "test" 14:04:59 INFO - } 14:04:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 14:04:59 INFO - Running post-action listener: _resource_record_post_action 14:04:59 INFO - [mozharness: 2017-02-15 22:04:59.687636Z] Finished read-buildbot-config step (success) 14:04:59 INFO - [mozharness: 2017-02-15 22:04:59.687725Z] Running download-and-extract step. 14:04:59 INFO - Running pre-action listener: _resource_record_pre_action 14:04:59 INFO - Running main action method: download_and_extract 14:04:59 INFO - mkdir: /builds/slave/test/build/tests 14:04:59 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')]} 14:04:59 INFO - trying https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 14:04:59 INFO - Downloading https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 14:04:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:05:00 INFO - Downloaded 1327 bytes. 14:05:00 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 14:05:00 INFO - Using the following test package requirements: 14:05:00 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 14:05:00 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:05:00 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:05:00 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:05:00 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 14:05:00 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:05:00 INFO - u'jsshell-linux-x86_64.zip'], 14:05:00 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:05:00 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:05:00 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 14:05:00 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:05:00 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 14:05:00 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:05:00 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 14:05:00 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:05:00 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:05:00 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:05:00 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:05:00 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:05:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 14:05:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:05:00 INFO - Fetch https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 14:05:00 INFO - Http code: 200 14:05:00 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 14:05:00 INFO - x-amz-cf-id: Vcq9RTaOIHlgON-qneqLa9coMLQ00ic-Qw5S6qj_6UC0cpLulHHrGQ== 14:05:00 INFO - x-amz-version-id: OYg_LqgITQtNu658dAChxe7GRE3kKPGm 14:05:01 INFO - Expected file size: 21958758 14:05:01 INFO - Obtained file size: 21958758 14:05:05 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:05:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 14:05:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:05:05 INFO - Fetch https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 14:05:05 INFO - Http code: 200 14:05:05 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 14:05:05 INFO - x-amz-cf-id: 24EI2ht9-dSmhv8RFeFwbBB6NhuwZQdeerVogi1Z0XEC8OHTRDHxFQ== 14:05:05 INFO - x-amz-version-id: OYg_LqgITQtNu658dAChxe7GRE3kKPGm 14:05:05 INFO - Expected file size: 21958758 14:05:05 INFO - Obtained file size: 21958758 14:05:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 14:05:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:05:10 INFO - Fetch https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 14:05:11 INFO - Http code: 200 14:05:11 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 14:05:11 INFO - x-amz-cf-id: gPLPdBlBpylUE0MwYPKvY8QJSRGtwKjwGTBO8iBwhxTz08W8iJ3h_g== 14:05:11 INFO - x-amz-version-id: YkVlv57ErFLbEAz1YzJA4WTI7i2C6s4p 14:05:12 INFO - Expected file size: 14403005 14:05:12 INFO - Obtained file size: 14403005 14:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:12 INFO - trying https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:05:12 INFO - Downloading https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:05:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:05:14 INFO - Downloaded 57737611 bytes. 14:05:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:05:14 INFO - mkdir: /builds/slave/test/properties 14:05:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:05:14 INFO - Writing to file /builds/slave/test/properties/build_url 14:05:14 INFO - Contents: 14:05:14 INFO - build_url:https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:05:15 INFO - Running post-action listener: _resource_record_post_action 14:05:15 INFO - Running post-action listener: set_extra_try_arguments 14:05:15 INFO - [mozharness: 2017-02-15 22:05:15.329237Z] Finished download-and-extract step (success) 14:05:15 INFO - [mozharness: 2017-02-15 22:05:15.329464Z] Running populate-webroot step. 14:05:15 INFO - Running pre-action listener: _resource_record_pre_action 14:05:15 INFO - Running main action method: populate_webroot 14:05:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:05:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:05:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:05:15 INFO - '--tppagecycles', 14:05:15 INFO - '7'], 14:05:15 INFO - 'tests': ['tsvgm']}}, 14:05:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:05:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:05:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:05:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:05:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:15 INFO - 'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:05:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:05:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:15 INFO - 'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['damp', 'tps']}, 14:05:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:15 INFO - 'tests': ['damp', 'tps']}, 14:05:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['dromaeo_dom']}, 14:05:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:05:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['basic_compositor_video']}, 14:05:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:05:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['a11yr', 14:05:15 INFO - 'ts_paint', 14:05:15 INFO - 'tpaint', 14:05:15 INFO - 'sessionrestore', 14:05:15 INFO - 'sessionrestore_no_auto_restore', 14:05:15 INFO - 'tabpaint']}, 14:05:15 INFO - 'other-e10s': {'tests': ['a11yr', 14:05:15 INFO - 'ts_paint', 14:05:15 INFO - 'tpaint', 14:05:15 INFO - 'sessionrestore', 14:05:15 INFO - 'sessionrestore_no_auto_restore', 14:05:15 INFO - 'tabpaint']}, 14:05:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:05:15 INFO - 'ts_paint', 14:05:15 INFO - 'tpaint', 14:05:15 INFO - 'sessionrestore', 14:05:15 INFO - 'sessionrestore_no_auto_restore', 14:05:15 INFO - 'tabpaint']}, 14:05:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:05:15 INFO - 'ts_paint', 14:05:15 INFO - 'tpaint', 14:05:15 INFO - 'sessionrestore', 14:05:15 INFO - 'sessionrestore_no_auto_restore', 14:05:15 INFO - 'tabpaint']}, 14:05:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['a11yr', 14:05:15 INFO - 'ts_paint', 14:05:15 INFO - 'tpaint', 14:05:15 INFO - 'sessionrestore', 14:05:15 INFO - 'sessionrestore_no_auto_restore', 14:05:15 INFO - 'tabpaint']}, 14:05:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['a11yr', 14:05:15 INFO - 'ts_paint', 14:05:15 INFO - 'tpaint', 14:05:15 INFO - 'sessionrestore', 14:05:15 INFO - 'sessionrestore_no_auto_restore', 14:05:15 INFO - 'tabpaint']}, 14:05:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['tsvgx', 14:05:15 INFO - 'tsvgr_opacity', 14:05:15 INFO - 'tart', 14:05:15 INFO - 'tscrollx', 14:05:15 INFO - 'cart']}, 14:05:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:05:15 INFO - 'tsvgr_opacity', 14:05:15 INFO - 'tart', 14:05:15 INFO - 'tscrollx', 14:05:15 INFO - 'cart']}, 14:05:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:15 INFO - 'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['tp5o']}, 14:05:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:15 INFO - 'tests': ['tp5o']}, 14:05:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:15 INFO - 'talos_options': ['--disable-e10s', 14:05:15 INFO - '--xperf_path', 14:05:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:05:15 INFO - 'tests': ['tp5n']}, 14:05:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:15 INFO - 'talos_options': ['--xperf_path', 14:05:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:05:15 INFO - 'tests': ['tp5n']}}, 14:05:15 INFO - 'talos.zip': {'path': '', 14:05:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:05:15 INFO - Running post-action listener: _resource_record_post_action 14:05:15 INFO - [mozharness: 2017-02-15 22:05:15.345369Z] Finished populate-webroot step (success) 14:05:15 INFO - [mozharness: 2017-02-15 22:05:15.345456Z] Running create-virtualenv step. 14:05:15 INFO - Running pre-action listener: _resource_record_pre_action 14:05:15 INFO - Running main action method: create_virtualenv 14:05:15 INFO - Creating virtualenv /builds/slave/test/build/venv 14:05:15 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 14:05:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:05:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:05:15 INFO - Using real prefix '/usr' 14:05:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:05:15 INFO - Installing distribute.............................................................................................................................................................................................done. 14:05:17 INFO - Installing pip.................done. 14:05:17 INFO - Return code: 0 14:05:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:05:18 INFO - Reading from file tmpfile_stdout 14:05:18 INFO - Output received: 14:05:18 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) 14:05:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:18 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 0x7f1f06a2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c79ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c76f60>, '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 0x1c77d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c781d0>, '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': '1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756', '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 14:05:18 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 14:05:18 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 14:05:18 INFO - Using env: {'DISPLAY': ':0', 14:05:18 INFO - 'HOME': '/home/cltbld', 14:05:18 INFO - 'LANG': 'en_US.UTF-8', 14:05:18 INFO - 'LANGUAGE': 'en_US:en', 14:05:18 INFO - 'LOGNAME': 'cltbld', 14:05:18 INFO - 'MAIL': '/var/mail/cltbld', 14:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:18 INFO - 'MOZ_NO_REMOTE': '1', 14:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:18 INFO - 'NO_EM_RESTART': '1', 14:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:18 INFO - 'PWD': '/builds/slave/test', 14:05:18 INFO - 'SHELL': '/bin/bash', 14:05:18 INFO - 'SHLVL': '1', 14:05:18 INFO - 'TERM': 'linux', 14:05:18 INFO - 'TMOUT': '86400', 14:05:18 INFO - 'USER': 'cltbld', 14:05:18 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756', 14:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:18 INFO - '_': '/tools/buildbot/bin/python'} 14:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:18 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 14:05:18 INFO - Cleaning up... 14:05:18 INFO - Return code: 0 14:05:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:18 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 0x7f1f06a2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c79ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c76f60>, '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 0x1c77d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c781d0>, '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': '1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756', '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 14:05:18 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 14:05:18 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 14:05:18 INFO - Using env: {'DISPLAY': ':0', 14:05:18 INFO - 'HOME': '/home/cltbld', 14:05:18 INFO - 'LANG': 'en_US.UTF-8', 14:05:18 INFO - 'LANGUAGE': 'en_US:en', 14:05:18 INFO - 'LOGNAME': 'cltbld', 14:05:18 INFO - 'MAIL': '/var/mail/cltbld', 14:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:18 INFO - 'MOZ_NO_REMOTE': '1', 14:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:18 INFO - 'NO_EM_RESTART': '1', 14:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:18 INFO - 'PWD': '/builds/slave/test', 14:05:18 INFO - 'SHELL': '/bin/bash', 14:05:18 INFO - 'SHLVL': '1', 14:05:18 INFO - 'TERM': 'linux', 14:05:18 INFO - 'TMOUT': '86400', 14:05:18 INFO - 'USER': 'cltbld', 14:05:18 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756', 14:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:18 INFO - '_': '/tools/buildbot/bin/python'} 14:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:18 INFO - Downloading/unpacking psutil>=3.1.1 14:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:05:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:20 INFO - Installing collected packages: psutil 14:05:20 INFO - Running setup.py install for psutil 14:05:20 INFO - building 'psutil._psutil_linux' extension 14:05:20 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 14:05:20 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 14:05:20 INFO - building 'psutil._psutil_posix' extension 14:05:20 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 14:05:21 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 14:05:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:21 INFO - Successfully installed psutil 14:05:21 INFO - Cleaning up... 14:05:21 INFO - Return code: 0 14:05:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:05: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')]} 14:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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')]} 14:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f06a2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c79ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c76f60>, '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 0x1c77d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c781d0>, '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': '1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756', '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 14:05: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:05: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 mozsystemmonitor==0.3 14:05:21 INFO - Using env: {'DISPLAY': ':0', 14:05:21 INFO - 'HOME': '/home/cltbld', 14:05:21 INFO - 'LANG': 'en_US.UTF-8', 14:05:21 INFO - 'LANGUAGE': 'en_US:en', 14:05:21 INFO - 'LOGNAME': 'cltbld', 14:05:21 INFO - 'MAIL': '/var/mail/cltbld', 14:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:21 INFO - 'MOZ_NO_REMOTE': '1', 14:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:21 INFO - 'NO_EM_RESTART': '1', 14:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:21 INFO - 'PWD': '/builds/slave/test', 14:05:21 INFO - 'SHELL': '/bin/bash', 14:05:21 INFO - 'SHLVL': '1', 14:05:21 INFO - 'TERM': 'linux', 14:05:21 INFO - 'TMOUT': '86400', 14:05:21 INFO - 'USER': 'cltbld', 14:05:21 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756', 14:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:21 INFO - '_': '/tools/buildbot/bin/python'} 14:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:05:23 INFO - Installing collected packages: mozsystemmonitor 14:05:23 INFO - Running setup.py install for mozsystemmonitor 14:05:23 INFO - Successfully installed mozsystemmonitor 14:05:23 INFO - Cleaning up... 14:05:23 INFO - Return code: 0 14:05:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f06a2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c79ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c76f60>, '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 0x1c77d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c781d0>, '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': '1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756', '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 14:05:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:05:23 INFO - Using env: {'DISPLAY': ':0', 14:05:23 INFO - 'HOME': '/home/cltbld', 14:05:23 INFO - 'LANG': 'en_US.UTF-8', 14:05:23 INFO - 'LANGUAGE': 'en_US:en', 14:05:23 INFO - 'LOGNAME': 'cltbld', 14:05:23 INFO - 'MAIL': '/var/mail/cltbld', 14:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:23 INFO - 'MOZ_NO_REMOTE': '1', 14:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:23 INFO - 'NO_EM_RESTART': '1', 14:05:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:23 INFO - 'PWD': '/builds/slave/test', 14:05:23 INFO - 'SHELL': '/bin/bash', 14:05:23 INFO - 'SHLVL': '1', 14:05:23 INFO - 'TERM': 'linux', 14:05:23 INFO - 'TMOUT': '86400', 14:05:23 INFO - 'USER': 'cltbld', 14:05:23 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756', 14:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:23 INFO - '_': '/tools/buildbot/bin/python'} 14:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:23 INFO - Downloading/unpacking jsonschema==2.5.1 14:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:05:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05:26 INFO - Downloading functools32-3.2.3-2.tar.gz 14:05:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:05:26 INFO - warning: no files found matching '*.txt' 14:05:26 INFO - no previously-included directories found matching 'build' 14:05:26 INFO - no previously-included directories found matching 'dist' 14:05:26 INFO - no previously-included directories found matching '.git*' 14:05:26 INFO - Installing collected packages: jsonschema, functools32 14:05:26 INFO - Running setup.py install for functools32 14:05:26 INFO - warning: no files found matching '*.txt' 14:05:26 INFO - no previously-included directories found matching 'build' 14:05:26 INFO - no previously-included directories found matching 'dist' 14:05:26 INFO - no previously-included directories found matching '.git*' 14:05:26 INFO - Successfully installed jsonschema functools32 14:05:26 INFO - Cleaning up... 14:05:26 INFO - Return code: 0 14:05:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1f06a2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c79ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c76f60>, '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 0x1c77d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c781d0>, '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': '1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756', '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 14:05:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:05:26 INFO - Using env: {'DISPLAY': ':0', 14:05:26 INFO - 'HOME': '/home/cltbld', 14:05:26 INFO - 'LANG': 'en_US.UTF-8', 14:05:26 INFO - 'LANGUAGE': 'en_US:en', 14:05:26 INFO - 'LOGNAME': 'cltbld', 14:05:26 INFO - 'MAIL': '/var/mail/cltbld', 14:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:26 INFO - 'MOZ_NO_REMOTE': '1', 14:05:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:26 INFO - 'NO_EM_RESTART': '1', 14:05:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:26 INFO - 'PWD': '/builds/slave/test', 14:05:26 INFO - 'SHELL': '/bin/bash', 14:05:26 INFO - 'SHLVL': '1', 14:05:26 INFO - 'TERM': 'linux', 14:05:26 INFO - 'TMOUT': '86400', 14:05:26 INFO - 'USER': 'cltbld', 14:05:26 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756', 14:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:26 INFO - '_': '/tools/buildbot/bin/python'} 14:05:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:05:26 INFO - Cleaning up... 14:05:26 INFO - Return code: 0 14:05:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1f06a2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c79ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c76f60>, '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 0x1c77d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c781d0>, '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': '1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756', '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 14:05:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:05:26 INFO - Using env: {'DISPLAY': ':0', 14:05:26 INFO - 'HOME': '/home/cltbld', 14:05:26 INFO - 'LANG': 'en_US.UTF-8', 14:05:26 INFO - 'LANGUAGE': 'en_US:en', 14:05:26 INFO - 'LOGNAME': 'cltbld', 14:05:26 INFO - 'MAIL': '/var/mail/cltbld', 14:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:26 INFO - 'MOZ_NO_REMOTE': '1', 14:05:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:26 INFO - 'NO_EM_RESTART': '1', 14:05:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:26 INFO - 'PWD': '/builds/slave/test', 14:05:26 INFO - 'SHELL': '/bin/bash', 14:05:26 INFO - 'SHLVL': '1', 14:05:26 INFO - 'TERM': 'linux', 14:05:26 INFO - 'TMOUT': '86400', 14:05:26 INFO - 'USER': 'cltbld', 14:05:26 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756', 14:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:26 INFO - '_': '/tools/buildbot/bin/python'} 14:05:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:26 INFO - Downloading/unpacking blobuploader==1.2.4 14:05:26 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 14:05:26 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 14:05:26 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 14:05:26 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 14:05:26 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 14:05:26 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 14:05:28 INFO - Downloading blobuploader-1.2.4.tar.gz 14:05:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:05:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:05:28 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 14:05:28 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 14:05:28 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 14:05:28 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 14:05:28 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 14:05:28 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 14:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:05:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05:29 INFO - Downloading docopt-0.6.1.tar.gz 14:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:05:29 INFO - Installing collected packages: blobuploader, requests, docopt 14:05:29 INFO - Running setup.py install for blobuploader 14:05:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:05:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:05:29 INFO - Running setup.py install for requests 14:05:30 INFO - Running setup.py install for docopt 14:05:30 INFO - Successfully installed blobuploader requests docopt 14:05:30 INFO - Cleaning up... 14:05:30 INFO - Return code: 0 14:05:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:05: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')]} 14:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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')]} 14:05:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:30 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 0x7f1f06a2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c79ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c76f60>, '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 0x1c77d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c781d0>, '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': '1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756', '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 14:05:30 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 14:05:30 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 14:05:30 INFO - Using env: {'DISPLAY': ':0', 14:05:30 INFO - 'HOME': '/home/cltbld', 14:05:30 INFO - 'LANG': 'en_US.UTF-8', 14:05:30 INFO - 'LANGUAGE': 'en_US:en', 14:05:30 INFO - 'LOGNAME': 'cltbld', 14:05:30 INFO - 'MAIL': '/var/mail/cltbld', 14:05:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:30 INFO - 'MOZ_NO_REMOTE': '1', 14:05:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:30 INFO - 'NO_EM_RESTART': '1', 14:05:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:30 INFO - 'PWD': '/builds/slave/test', 14:05:30 INFO - 'SHELL': '/bin/bash', 14:05:30 INFO - 'SHLVL': '1', 14:05:30 INFO - 'TERM': 'linux', 14:05:30 INFO - 'TMOUT': '86400', 14:05:30 INFO - 'USER': 'cltbld', 14:05:30 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756', 14:05:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:30 INFO - '_': '/tools/buildbot/bin/python'} 14:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:05:30 INFO - Running setup.py (path:/tmp/pip-KA2TDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:05:30 INFO - Running setup.py (path:/tmp/pip-O4x6Ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:05:30 INFO - Running setup.py (path:/tmp/pip-yJuTLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:05:30 INFO - Running setup.py (path:/tmp/pip-WUBTUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:05:30 INFO - Running setup.py (path:/tmp/pip-abgD2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:05:30 INFO - Running setup.py (path:/tmp/pip-CT1Sqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:05:30 INFO - Running setup.py (path:/tmp/pip-eRnvaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:05:30 INFO - Running setup.py (path:/tmp/pip-ZDkUOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:05:31 INFO - Running setup.py (path:/tmp/pip-bu7HgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:05:31 INFO - Running setup.py (path:/tmp/pip-rfat1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:05:31 INFO - Running setup.py (path:/tmp/pip-6c4lVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:05:31 INFO - Running setup.py (path:/tmp/pip-kn4Nxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:05:31 INFO - Running setup.py (path:/tmp/pip-ifcC7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:05:31 INFO - Running setup.py (path:/tmp/pip-3FsZ_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:31 INFO - Running setup.py (path:/tmp/pip-5JPTp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:05:31 INFO - Running setup.py (path:/tmp/pip-Ex8Aor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:05:31 INFO - Running setup.py (path:/tmp/pip-3Ivjl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:05:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:05:31 INFO - Running setup.py install for manifestparser 14:05:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:05:31 INFO - Running setup.py install for mozcrash 14:05:31 INFO - Running setup.py install for mozdebug 14:05:31 INFO - Running setup.py install for mozdevice 14:05:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:05:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:05:32 INFO - Running setup.py install for mozfile 14:05:32 INFO - Running setup.py install for mozhttpd 14:05:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:05:32 INFO - Running setup.py install for mozinfo 14:05:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:05:32 INFO - Running setup.py install for mozInstall 14:05:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:05:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:05:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:05:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:05:32 INFO - Running setup.py install for mozleak 14:05:32 INFO - Running setup.py install for mozlog 14:05:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:05:32 INFO - Running setup.py install for moznetwork 14:05:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:05:32 INFO - Running setup.py install for mozprocess 14:05:32 INFO - Running setup.py install for mozprofile 14:05:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:05:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:05:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:05:33 INFO - Running setup.py install for mozrunner 14:05:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:05:33 INFO - Running setup.py install for mozscreenshot 14:05:33 INFO - Running setup.py install for moztest 14:05:33 INFO - Running setup.py install for mozversion 14:05:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:05:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:05:33 INFO - Cleaning up... 14:05:33 INFO - Return code: 0 14:05:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:05: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')]} 14:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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')]} 14:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:33 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 0x7f1f06a2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c79ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c76f60>, '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 0x1c77d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c781d0>, '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': '1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756', '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 14:05:33 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 14:05:33 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 14:05:33 INFO - Using env: {'DISPLAY': ':0', 14:05:33 INFO - 'HOME': '/home/cltbld', 14:05:33 INFO - 'LANG': 'en_US.UTF-8', 14:05:33 INFO - 'LANGUAGE': 'en_US:en', 14:05:33 INFO - 'LOGNAME': 'cltbld', 14:05:33 INFO - 'MAIL': '/var/mail/cltbld', 14:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:33 INFO - 'MOZ_NO_REMOTE': '1', 14:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:33 INFO - 'NO_EM_RESTART': '1', 14:05:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:33 INFO - 'PWD': '/builds/slave/test', 14:05:33 INFO - 'SHELL': '/bin/bash', 14:05:33 INFO - 'SHLVL': '1', 14:05:33 INFO - 'TERM': 'linux', 14:05:33 INFO - 'TMOUT': '86400', 14:05:33 INFO - 'USER': 'cltbld', 14:05:33 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756', 14:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:33 INFO - '_': '/tools/buildbot/bin/python'} 14:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:05:33 INFO - Running setup.py (path:/tmp/pip-Z1I971-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:05:33 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)) 14:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:05:33 INFO - Running setup.py (path:/tmp/pip-G9pCBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:05:33 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)) 14:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:05:33 INFO - Running setup.py (path:/tmp/pip-wXuS8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:05:33 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)) 14:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:05:33 INFO - Running setup.py (path:/tmp/pip-Vac0jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:05:34 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)) 14:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:05:34 INFO - Running setup.py (path:/tmp/pip-FeFF_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:05:34 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)) 14:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:05:34 INFO - Running setup.py (path:/tmp/pip-U8DpPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:05:34 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)) 14:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:05:34 INFO - Running setup.py (path:/tmp/pip-e8kgzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:05:34 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)) 14:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:05:34 INFO - Running setup.py (path:/tmp/pip-SqTMnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:05:34 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)) 14:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:05:34 INFO - Running setup.py (path:/tmp/pip-CIxiDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:05:34 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)) 14:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:05:34 INFO - Running setup.py (path:/tmp/pip-rIk54j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:05:34 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)) 14:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:05:34 INFO - Running setup.py (path:/tmp/pip-RLeeT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:05:34 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)) 14:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:05:34 INFO - Running setup.py (path:/tmp/pip-NmC7VH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:05:34 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)) 14:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:05:34 INFO - Running setup.py (path:/tmp/pip-fwvfS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:05:34 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)) 14:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:05:34 INFO - Running setup.py (path:/tmp/pip-6jBLvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:05:34 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)) 14:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:34 INFO - Running setup.py (path:/tmp/pip-eIlCTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:34 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)) 14:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:05:34 INFO - Running setup.py (path:/tmp/pip-U2qjmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:05:34 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)) 14:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:05:34 INFO - Running setup.py (path:/tmp/pip-NcyQBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:05:34 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)) 14:05:34 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)) 14:05:34 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)) 14:05:34 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)) 14:05:34 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)) 14:05:34 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)) 14:05:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:37 INFO - Downloading blessings-1.6.tar.gz 14:05:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:05:37 INFO - Installing collected packages: blessings 14:05:37 INFO - Running setup.py install for blessings 14:05:37 INFO - Successfully installed blessings 14:05:37 INFO - Cleaning up... 14:05:37 INFO - Return code: 0 14:05:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:05:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:05:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:05:37 INFO - Reading from file tmpfile_stdout 14:05:37 INFO - Current package versions: 14:05:37 INFO - argparse == 1.2.1 14:05:37 INFO - blessings == 1.6 14:05:37 INFO - blobuploader == 1.2.4 14:05:37 INFO - docopt == 0.6.1 14:05:37 INFO - functools32 == 3.2.3-2 14:05:37 INFO - jsonschema == 2.5.1 14:05:37 INFO - manifestparser == 1.1 14:05:37 INFO - mozInstall == 1.12 14:05:37 INFO - mozcrash == 1.0 14:05:37 INFO - mozdebug == 0.1 14:05:37 INFO - mozdevice == 0.48 14:05:37 INFO - mozfile == 1.2 14:05:37 INFO - mozhttpd == 0.7 14:05:37 INFO - mozinfo == 0.9 14:05:37 INFO - mozleak == 0.1 14:05:37 INFO - mozlog == 3.4 14:05:37 INFO - moznetwork == 0.27 14:05:37 INFO - mozprocess == 0.23 14:05:37 INFO - mozprofile == 0.28 14:05:37 INFO - mozrunner == 6.13 14:05:37 INFO - mozscreenshot == 0.1 14:05:37 INFO - mozsystemmonitor == 0.3 14:05:37 INFO - moztest == 0.8 14:05:37 INFO - mozversion == 1.4 14:05:37 INFO - psutil == 3.1.1 14:05:37 INFO - requests == 1.2.3 14:05:37 INFO - wsgiref == 0.1.2 14:05:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:05: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')]} 14:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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')]} 14:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:37 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 0x7f1f06a2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c79ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c76f60>, '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 0x1c77d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c781d0>, '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': '1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756', '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 14:05:37 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 14:05:37 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 14:05:37 INFO - Using env: {'DISPLAY': ':0', 14:05:37 INFO - 'HOME': '/home/cltbld', 14:05:37 INFO - 'LANG': 'en_US.UTF-8', 14:05:37 INFO - 'LANGUAGE': 'en_US:en', 14:05:37 INFO - 'LOGNAME': 'cltbld', 14:05:37 INFO - 'MAIL': '/var/mail/cltbld', 14:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:37 INFO - 'MOZ_NO_REMOTE': '1', 14:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:37 INFO - 'NO_EM_RESTART': '1', 14:05:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:37 INFO - 'PWD': '/builds/slave/test', 14:05:37 INFO - 'SHELL': '/bin/bash', 14:05:37 INFO - 'SHLVL': '1', 14:05:37 INFO - 'TERM': 'linux', 14:05:37 INFO - 'TMOUT': '86400', 14:05:37 INFO - 'USER': 'cltbld', 14:05:37 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756', 14:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:37 INFO - '_': '/tools/buildbot/bin/python'} 14:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:37 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)) 14:05:37 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)) 14:05:37 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)) 14:05:37 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)) 14:05:37 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)) 14:05:37 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)) 14:05:37 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)) 14:05:37 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)) 14:05:37 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)) 14:05:37 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)) 14:05:37 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)) 14:05:37 INFO - Cleaning up... 14:05:37 INFO - Return code: 0 14:05:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:05: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')]} 14:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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')]} 14:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:37 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 0x7f1f06a2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c79ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c76f60>, '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 0x1c77d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c781d0>, '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': '1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756', '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 14:05:37 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 14:05:37 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 14:05:37 INFO - Using env: {'DISPLAY': ':0', 14:05:37 INFO - 'HOME': '/home/cltbld', 14:05:37 INFO - 'LANG': 'en_US.UTF-8', 14:05:37 INFO - 'LANGUAGE': 'en_US:en', 14:05:37 INFO - 'LOGNAME': 'cltbld', 14:05:37 INFO - 'MAIL': '/var/mail/cltbld', 14:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:37 INFO - 'MOZ_NO_REMOTE': '1', 14:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:37 INFO - 'NO_EM_RESTART': '1', 14:05:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:37 INFO - 'PWD': '/builds/slave/test', 14:05:37 INFO - 'SHELL': '/bin/bash', 14:05:37 INFO - 'SHLVL': '1', 14:05:37 INFO - 'TERM': 'linux', 14:05:37 INFO - 'TMOUT': '86400', 14:05:37 INFO - 'USER': 'cltbld', 14:05:37 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756', 14:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:37 INFO - '_': '/tools/buildbot/bin/python'} 14:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:05:37 INFO - Cleaning up... 14:05:37 INFO - Return code: 0 14:05:37 INFO - Running post-action listener: _resource_record_post_action 14:05:37 INFO - Running post-action listener: _start_resource_monitoring 14:05:37 INFO - Starting resource monitoring. 14:05:37 INFO - [mozharness: 2017-02-15 22:05:37.982577Z] Finished create-virtualenv step (success) 14:05:37 INFO - [mozharness: 2017-02-15 22:05:37.983077Z] Running install step. 14:05:37 INFO - Running pre-action listener: _resource_record_pre_action 14:05:37 INFO - Running main action method: install 14:05:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:05:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:05:38 INFO - Reading from file tmpfile_stdout 14:05:38 INFO - Detecting whether we're running mozinstall >=1.0... 14:05:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:05:38 INFO - Reading from file tmpfile_stdout 14:05:38 INFO - Output received: 14:05:38 INFO - Usage: mozinstall [options] installer 14:05:38 INFO - Options: 14:05:38 INFO - -h, --help show this help message and exit 14:05:38 INFO - -d DEST, --destination=DEST 14:05:38 INFO - Directory to install application into. [default: 14:05:38 INFO - "/builds/slave/test"] 14:05:38 INFO - --app=APP Application being installed. [default: firefox] 14:05:38 INFO - mkdir: /builds/slave/test/build/application 14:05:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:05:52 INFO - Reading from file tmpfile_stdout 14:05:52 INFO - Output received: 14:05:52 INFO - /builds/slave/test/build/application/firefox/firefox 14:05:52 INFO - Running post-action listener: _resource_record_post_action 14:05:52 INFO - [mozharness: 2017-02-15 22:05:52.037771Z] Finished install step (success) 14:05:52 INFO - [mozharness: 2017-02-15 22:05:52.038015Z] Running run-tests step. 14:05:52 INFO - Running pre-action listener: _resource_record_pre_action 14:05:52 INFO - Running main action method: run_tests 14:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:05:52 INFO - Python 2.7.3 14:05:52 INFO - Return code: 0 14:05:52 INFO - grabbing minidump binary from tooltool 14:05:52 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')]} 14:05:52 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 0x1c76f60>, '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 0x1c77d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c781d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:05:52 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 14:05:52 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 14:05:52 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 14:05:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:05:52 INFO - Return code: 0 14:05:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:05:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:05:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:05:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:05:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 14:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-079 --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 14:05:52 INFO - Using env: {'DISPLAY': ':0', 14:05:52 INFO - 'HOME': '/home/cltbld', 14:05:52 INFO - 'LANG': 'en_US.UTF-8', 14:05:52 INFO - 'LANGUAGE': 'en_US:en', 14:05:52 INFO - 'LOGNAME': 'cltbld', 14:05:52 INFO - 'MAIL': '/var/mail/cltbld', 14:05:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:05:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:52 INFO - 'MOZ_NO_REMOTE': '1', 14:05:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:52 INFO - 'NO_EM_RESTART': '1', 14:05:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:52 INFO - 'PWD': '/builds/slave/test', 14:05:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:05:52 INFO - 'SHELL': '/bin/bash', 14:05:52 INFO - 'SHLVL': '1', 14:05:52 INFO - 'TERM': 'linux', 14:05:52 INFO - 'TMOUT': '86400', 14:05:52 INFO - 'USER': 'cltbld', 14:05:52 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756', 14:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:52 INFO - '_': '/tools/buildbot/bin/python'} 14:05:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 14:05:52 INFO - mozversion application_buildid: 20170215120914 14:05:52 INFO - mozversion application_changeset: c79b61700177693e486bd968dfd51f38c8781f0a 14:05:52 INFO - mozversion application_display_name: Firefox 14:05:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:05:52 INFO - mozversion application_name: Firefox 14:05:52 INFO - mozversion application_remotingname: firefox 14:05:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:05:52 INFO - mozversion application_vendor: Mozilla 14:05:52 INFO - mozversion application_version: 52.0 14:05:52 INFO - mozversion platform_buildid: 20170215120914 14:05:52 INFO - mozversion platform_changeset: c79b61700177693e486bd968dfd51f38c8781f0a 14:05:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:05:52 INFO - mozversion platform_version: 52.0 14:05:52 INFO - using testdate: 1487196352 14:05:52 INFO - actual date: 1487196352 14:05:52 INFO - starting webserver on 'localhost:52808' 14:05:52 INFO - SUITE-START | Running 2 tests 14:05:52 INFO - TEST-START | dromaeo_css 14:05:52 INFO - operating with platform_type : linux_ 14:05:52 INFO - Initialising browser for dromaeo_css test... 14:05:52 INFO - TEST-INFO | started process 15999 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUnAX60/profile http://localhost:52808/getInfo.html) 14:05:56 INFO - PROCESS | 15999 | __metrics Screen width/height:1600/1200 14:05:56 INFO - PROCESS | 15999 | colorDepth:24 14:05:56 INFO - PROCESS | 15999 | Browser inner width/height: 1024/697 14:05:56 INFO - PROCESS | 15999 | __metrics 14:05:57 INFO - PROCESS | 15999 | 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" 14:05:57 INFO - PROCESS | 15999 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:05:57 INFO - PROCESS | 15999 | console.error: PushService: 14:05:57 INFO - PROCESS | 15999 | stateChangeProcessEnqueue: Error transitioning state 14:05:57 INFO - PROCESS | 15999 | UnknownError 14:05:58 INFO - TEST-INFO | 15999: exit 0 14:05:58 INFO - Browser initialized. 14:05:58 INFO - Running cycle 1/1 for dromaeo_css test... 14:05:58 INFO - TEST-INFO | started process 16095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUnAX60/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:06:10 INFO - PROCESS | 16095 | RSS: Main: 141869056 14:06:10 INFO - PROCESS | 16095 | 14:09:11 INFO - PROCESS | 16095 | Cycle 1(1): loaded http://localhost:52808/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52808/tests/dromaeo/cssquery-ext.html) 14:09:12 INFO - PROCESS | 16095 | RSS: Main: 231813120 14:09:12 INFO - PROCESS | 16095 | 14:12:15 INFO - PROCESS | 16095 | Cycle 1(1): loaded http://localhost:52808/tests/dromaeo/cssquery-ext.html (next: http://localhost:52808/tests/dromaeo/cssquery-jquery.html) 14:12:15 INFO - PROCESS | 16095 | RSS: Main: 237072384 14:12:15 INFO - PROCESS | 16095 | 14:15:17 INFO - PROCESS | 16095 | Cycle 1(1): loaded http://localhost:52808/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52808/tests/dromaeo/cssquery-mootools.html) 14:15:18 INFO - PROCESS | 16095 | RSS: Main: 176238592 14:15:18 INFO - PROCESS | 16095 | 14:18:20 INFO - PROCESS | 16095 | Cycle 1(1): loaded http://localhost:52808/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52808/tests/dromaeo/cssquery-prototype.html) 14:18:20 INFO - PROCESS | 16095 | RSS: Main: 217731072 14:18:20 INFO - PROCESS | 16095 | 14:21:23 INFO - PROCESS | 16095 | Cycle 1(1): loaded http://localhost:52808/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52808/tests/dromaeo/cssquery-yui.html) 14:21:24 INFO - PROCESS | 16095 | RSS: Main: 176418816 14:21:24 INFO - PROCESS | 16095 | 14:24:26 INFO - PROCESS | 16095 | Cycle 1(1): loaded http://localhost:52808/tests/dromaeo/cssquery-yui.html (next: http://localhost:52808/tests/dromaeo/cssquery-dojo.html) 14:24:26 INFO - PROCESS | 16095 | RSS: Main: 263450624 14:24:26 INFO - PROCESS | 16095 | 14:24:26 INFO - PROCESS | 16095 | __start_tp_report 14:24:26 INFO - PROCESS | 16095 | _x_x_mozilla_page_load 14:24:26 INFO - PROCESS | 16095 | _x_x_mozilla_page_load_details 14:24:26 INFO - PROCESS | 16095 | |i|pagename|runs| 14:24:26 INFO - PROCESS | 16095 | |0;dojo.html;3225.854836532356;3238.6275578308487;3259.55995940548;3292.407366673998;3312.2878581105056;5497.285352904122;5582.637128586644;5590;5594.944050559493;5600.523955463786;5612.831615051555;5679.290088738908;5681.914771278423;5688.63023903446;5720.427957204278;5077.111505486543;5129;5131.634099119776;5164.2253661950635;5206.245094461301;5003.274525193845;5004.624653151028;5218.1650935850275;5227.47725227478;5249.370075590934;5011.949880501184;5025.472325405834;5028.899422011557;5109.514596113363;5111.488851114877;5117.385913690362;5194.298769666122;5204.479552044765;5211.166213405856;5237.8428647140645;4913.238448040559;4918.385201849769;5114.923276150861;5126.384833819928;5163.302954101224;5468.562514998791;5478.342598888159;5490.752916118784;5493.450654934514;5509.118541033456;6000.279966404016;6046.183765191687;6047.395260473962;6050.394960503959;6052.636841789506;5859.6191247569195;5886.028805247129;6078.939210607926;6087.786927457518;6093.512518998469;5518.392976772552;5545.861353466155;5567.832965011056;5613.298337707786;5616.494515493625;6129.816105516842;6133.846653833601;6140.3552626974415;6143.907841382383;6147.784827531015;5680.261565996394;5729.541636669056;5899;5905.557083218776;5913.408659134052;5897.675627840425;5925.970370148121;5970.104484327298;5976.551758618121;5979.701014949235;5903.645781253139;5904.143899134601;5913.29040515141;5913.408659134052;5920.496757775637;5849.181114643953;5864.7947321844385;5911.142884281755;5918.8816223675285;5932.466078052909;4634;4645.6980296280635;4670.929936050962;4672.065586882637;4674.182018146811;4110.8561200358445;4119.732217405919;4192.266353388145;4216.030313028021;4224.45082139326;5755.309362876482;5761.971190144106;5767.8558036049435;5768.221290125864;5783.652980821164;5999.490043346277;6026.5178785697035;6033.4871535919065;6041.275046994301;6045.667488288186;5547.084731019418;5590.357108932443;5600.663960162403;5620.044592419298;5774.04728219839;5130.589552835764;5131.846044618667;5136.948630513722;5142.382914050338;5164.664296820694;6201.937980620226;6213.627182369072;6215.471684906834;6220.066989951543;6225.408586184305;5808.39011903744;5815.651060936358;5888.116782482662;5916.911246331222;5972.372900845348;6177.96911015442;6248.031555108783;6288.748450061947;6298.433141017331;6299.023651333867;5897.882042359043;5902.2622172228475;5903.144044113494;5908.813018475057;5939.7921072763975;5883.970580147243;5940.584159108821;5963.642181469126;5990;5998.550108741949;5810.82567522975;5882.558808089325;5900.085486749561;5908.379620139824;5918.40815918422;5822.650640961556;5832.24180856486;5865.384134665969;5878.676672783038;5879.882402351844;5649.802256921153;5656.830295091154;5849.853753656193;5851.034579294369;5856.970715146397;5708.828735137952;5720.713964301685;5740.425957404226;5801.1878337033695;5836.678982655994;5664.830055098354;5667.40492248308;5670.631408958405;5672.4894759471845;5678.858028549319 14:24:26 INFO - PROCESS | 16095 | |1;ext.html;572.687885102619;575.6028340445096;588.0591054313097;619.8202521268832;643.7746788623982;27767.30581735455;38286.808565957166;39030.41454378179;39094.60905390945;39096.609033909685;45643.315350269775;45969.7701511492;46072.308915366295;46086.53913460873;46254.537454625446;7771.106322772869;8872.423292485984;9025.684101056464;9026.458412495238;9027.232685221765;7845.568493732842;10692.625758098467;10899.182561307895;10899.673009809718;11225.438728063606;10580.576776928914;10620.150387968944;10630.78738425231;10636.095931845803;10644.882287359831;10582.629607963685;10610.257281990263;10624.57501699935;10628.734281642983;10638;10737.731556711145;10837;10837.241393102486;10837.891621083767;10838.078763305128;42232.78883605593;42357.576424235674;42666.78666606647;42680.78659606713;42684;3587.3722098632634;3706.166112624665;3715.702743780518;4069.651938970116;4235.4917409911;34594.827025864965;34634;34682.65317346819;34749.30501389983;34791.826040869884;4511.547413021399;4540.954590454086;4548.909021819578;4552.8861778455475;4613.953860461386;320318;321751.9999999977;321823;322278;322351;62397.68801155965;63051;63109;63112;63116.68441657762;38827.80586097051;39573;39811.80094099569;41482;41625.1674966499;15348.693026139415;15564.92217538905;15566.688666226839;15571.377144914077;15575.76636350433;9456.527173641429;9682.56428460721;10290.845637315446;10398.376097434179;10567.577296908192;19508.219671213275;19919.60160796776;19941.302054428026;20002.89998549998;20079.096440660207;7321.048263725788;7321.059919121437;7326.9267307326245;7358.300961408658;7602.657880395395;969.2149359019216;981.087588542648;1008.3193844155165;1058.8147074262126;1143.4854315557866;30795.38409231803;30822.53766193509;31364.686353136178;32636.02091937246;32976.835115824266;1097.9066779323846;1149.6091328948198;1152.9654110376703;1191.3209470601846;1222.0468034932767;14731.779023314659;15402.383904643688;15408.614784630474;15475;15508.844911550967;453276;456022;457346;457648;459453;47113.52886471091;47577.76211118922;47638;47638.523614764104;47653.28520072201;1033.1115240892825;1059.0786016165985;1351.115019662123;1423.3025817349424;1458.7811828225638;28961.42077158487;32329.51505727463;32780.1804954878;32858.34283314368;32908.34183316368;49649;50210.74894625504;50238.74880625573;50293.49706502888;50331.24503132383;375671;379726;380043;380081;380134;22507.774922250566;22950.77049229553;28214.43571128525;29287.56068658929;29338.559921600765;45227.77386113048;45393.546064540256;45505.317420239386;45566.544334557555;45676;37245.25509489849;37898.43152352662;38080.619193808816;38640.42039369468;39644.40533392059;38738.6126138735;39208.607913920496;39212.2157556853;39317;40580;39252.214955700154;39553.011174720865;44325.33511997387;45484.545154549356;45667.314990274506;34731;37612;37785;37785.433218502294;37825.432618511295;33030.669693302756;34907.82546087253;35116.29767404586;35120.47319290161;35149.824250878584 14:24:26 INFO - PROCESS | 16095 | |2;jquery.html;408.583245090008;423.5806551514002;426.48821414302836;431.4451963027274;436.4871276250406;18166.90916545417;18491.352802651894;19551.804481955176;19802.405927822154;19865.702014469796;19303.517412064706;19782.10980505877;19791.703124453146;19826.008699565;20104.296349627766;5734.770609175638;5841.386654401291;5864.648121112726;5872.207252020987;5880.8235752927485;5679.148127780824;5783.277090363705;5818.359980402152;5915.231019967398;5916.911246331309;5804.709764511778;5806.9709651451685;5819.82540523785;5822.650640961556;5831.591788574801;5609.102543593026;5729.427057294279;5770.451807078321;5807.41925807418;5809.7676092956235;5214.556762675177;5219.243209734567;5223.608229382773;5223.791048358061;5224.895502089975;18812.623747524973;21886.343409697736;22541.661875071888;22788.08847646092;22794.54410911789;2336.9532609347716;2441.182203961675;2807.73326533981;3122.78140530163;3153.4008538377866;10307.875657960061;10315.484225788756;10600.363978161335;10847.67456976292;10855.077318427942;1954.355062829263;2008.7288216090788;2018.8082132197417;2031.1976769176092;2052.5176583502866;64224.3577564223;67727.32272677259;70092;75550.24449755487;77400;10913.945430272957;10985.725356865982;11343.829842552368;11354.48904799286;11581.76836463266;16696.83303166953;16749.497515074567;16753.581160470843;16764.748528772077;16780.32878684839;7818.100918394343;7827.765167044884;7844.37245020397;7937.126916039231;7976.361891048702;7164.749233776793;7197.568145911262;7440.590767507731;7543.698252069966;7634.083909930733;4974.7512624369365;5075.568576671024;5091.516305950929;5116.462771409023;5219.5041471060185;1959.8726082804571;2036.3890832750117;2038.1134206619872;2061.3197644777188;2065.865718728278;942.6465075596651;978.3689520259393;1047.1413440978324;1053.441675911768;1081.605214096849;18238.41641058389;18608.627827443375;18828.246870125316;19173.32893348726;19536.21855125779;930.2186163622589;966.2270183852889;1003.2325271167563;1014.5688082564881;1027.6505987964129;10115;10747.677569672922;10761.408122553177;10797.29817561856;11058;440160;440814;442006;448538;449551;56123.158152627744;96773.16134193403;97232;97234.5138274304;97567;995.6365926436944;1047.6280920273346;1056.1550759392455;1058.0583280880023;1058.7564860082225;16956;17424.738628920324;17472.213750381008;17552;17817.1982260796;35239.295214096084;37138.814305928296;42520;42915.356269655356;43330.56669433265;57676;58053.4194658048;59142;59270;60018.59925602927;7820.491668041559;8005.079415867017;8128.187181281824;8134.227248411392;8318;10250.282480226313;11531.481083351437;11899;12049.638510844688;12459.563915262923;10311.020453056948;10481.58073677075;10720.249582529148;10900.836487452852;10988.120950324115;4715.882102947454;6038.849028774316;10276;10527.210459215436;10555.472226388496;7882.881756773539;10602.20483463728;10617.522211500347;10884.40135792539;11145.888541114486;7853.725119620786;7949.8410031800195;8165.183481651788;8290.958545207235;8642.956785216034;10596.47017649099;10625.203109766644;10701.304415213297;10725.410102444128;10832.945835270773 14:24:26 INFO - PROCESS | 16095 | |3;mootools.html;1071.8499410082595;1256.0265794009645;1369.5001324516554;1385.127369757053;1850.9537261568466;7402.6668799904;8518;8769.60536775845;8769.693060742859;8971.506567138806;8787.824243515126;8868.068852770462;8871.467711937272;8874.55627218638;8881.911180888206;2424.1151979527476;2426.0349117215023;2451.4974430241846;2454.1165180534995;2454.447749256421;2389.880505974694;2398.8080953523677;2418.3833122553724;2447.877606119696;2453.2272334214754;2369.7985671217966;2378.9643155352683;2403.3390817525233;2406.42245860993;2411.3127758588807;2283.8515496492673;2288.119074156445;2308.9307320780404;2309.030207312924;2317.2584772872688;2306.0545176477563;2309.6535519672016;2334.6381310896836;2335.719713634358;2336.3107883174503;8715.084916083782;8819.559022048936;8873.467591944504;8894.777630559223;8946.552672366355;5422.8373148805595;5554.250176226198;5576.776928922838;5580.246666699984;5592.273004509429;3335.816530090844;3432.3478539077496;3453.9465463033766;3459.2043829919257;3490.7381946354126;1103.9227254092216;1112.6383925224334;1129.5425352732075;1158.322381406878;1167.5038108803724;12486.12597118202;12532.624021279376;12580.308083055428;12586.056045796602;12602.873971260262;4298.4197133387215;4578.5421457853945;4611;4647.488776234612;4667.463241727177;9828.164606008426;9832.115109640166;9834.80330393388;9840.901590983998;9842.311038227255;5417.647852889629;5421.756020979065;5422.8373148805595;5423.29497165366;5426.430224826416;4076.164386300801;4254.574542545783;4297.54875738043;4319.200947824663;5088.338515992898;3862.8261728222296;3901.4733011043713;4008.398740188995;4029.0531725044593;4029.1135950090934;1172.5192671005018;1172.9824052639217;1176.5235079792697;1195.9714645404945;1226.8405107336168;826.3636999510344;832.0597724571317;884.9645914280308;892.2326798952895;975.4829940131741;5818.080033588905;5871.178035075093;5892.204552385373;5919;6104.938950610526;865.8138500222483;874.8818909447143;898.4743924803932;965.8406362950175;978.2614126334572;3716.758410703296;3834.386498160281;3851.056491159684;3865.8260378283044;3890.9610903891166;10759.3544387337;11208.775824483464;11217.495212715447;11273.887261127447;11281.153913456523;11150.776984460266;11160.944195278971;11163;11167.441627918572;11171.21801473889;8000.399970002273;8326.50040997542;8327.958360208282;8391.580420978926;8521.659133634708;5549.278593782782;5712.400197979318;5722.4277572242445;5820.592558520862;5848.766049357978;9834.459104749021;10102.494875256061;10137.087662110445;10141.239407044648;10154.339967902062;9168.495732734764;9454.385464944757;10105.494725263561;10268.178545716175;10368.844467332845;7614.581198034161;7911.683532658629;7915.287624113857;7979.441439099207;8095.190480952093;8668.609912553824;8681.696140635047;8742.606582703665;8776.824463510566;8780.604872780612;7533.359664428585;7586.393088553013;7722.5366478009255;7734.419918506022;7767.844643107219;7544.8491030180185;7601.3918886490055;7622.390208783395;7635.198304178203;7883.251091146332;6806.93193068063;6913.446924246149;6919.031335613119;6919.411849992807;6924.930750692429;5007.799688012438;5068.82259120929;5071.771770270273;5083.1358669027095;5295.920561191509;4757.238841785298;4796.760161991817;4869;4964.230544265644;5069.087564238473 14:24:26 INFO - PROCESS | 16095 | |4;prototype.html;348.8290737538607;349.5089399393851;354.18890740204915;355.2167470727047;361.625717382509;5174.861530463292;5214.530692237698;5360.892782144355;5373.489518495741;5383.89232215356;5092.911906118492;5212.8696782580455;5234.7120908350025;5265.684058956465;5272.446393128724;4189.811458484361;4213.936790948138;4218.367244913257;4222.662187025046;4292.034292284242;4004.7985604318587;4200.957990420087;4240.681948853833;4248.9575104249025;4296.677749168809;4175.100329350138;4181.247375472413;4187.769672668002;4191.81136848841;4198.496180458334;4153.937690934638;4173.975621823429;4175.269327867611;4178.080822219107;4201.810918508644;3734.8879533614036;3744.7753134811996;3745.6441638044616;3751.0997360633523;3757.6618104370464;5028.446870844205;5086.72831792052;5144;5145.945081258333;5161.3806343238675;4743.169945259566;4750.548697873696;4756.976215118937;4759.785809638574;4772.689775164603;5442.729086130353;5453.727313634342;5498.367687715924;5499.587530935196;5525.11598144299;3959.3665013597974;4014.3978403239457;4035.556088830226;4047.392891066334;4056.290149223874;5630.971845140789;5665.971670141664;5676.943230567683;5677.460641239076;5700.828975130753;4136.338185890303;4152.460180176618;4156.314208155621;4161.791910404468;4173.078844808646;4007.937896457441;4165.645920096765;4167.604077612622;4170.645495132887;4230.682698797603;4659.603933665609;4704.458987216445;4708.128996135726;4709.270063140219;4726.858194254178;5505.944940550623;5530.55755539564;5538.612297139242;5552.305961754781;5554.833354999357;1314.0604467805374;1329.335332333833;1337.6789570503204;1380.9171449713049;1392.9512467063605;961.7595601099725;974.5809302000208;975.22956864078;978.8923218445965;988.3081842710131;5205.895882082413;5226.451222621646;5230.712310822865;5235.345581802275;5239.318888544465;5471.890562188813;5472.452754724496;5477.507024367826;5526.861828454241;5545.639533430314;5179.61152913533;5215.357162493802;5226.790928362823;5228.215767634885;5462.7268636568015;2876.467853447119;2891.715544719648;2929.5898574199628;2933;2953.3354995126356;5694.743736531866;5716.5140963017775;5733.971330143323;5740.942590574125;5753.194552762617;5421.105517589633;5526.50784288248;5529.502344788988;5546.77812887488;5595.118513965311;5679.920815045129;5682.346530149003;5684.54523638108;5709.115087161496;5709.600327977002;5292.391374991771;5444.509994100392;5458.7990642058685;5487.533559647474;5502.339719233718;5417.702026388429;5458.6724796512335;5467.808626698046;5471.699056551928;5474.288342515607;5701.942980570141;5772.91983054909;5773.307203135482;5779.739911703899;5783.334916484658;3895.6493915547735;3998.440218369489;4012.398140278865;4019.4774679291504;4025.3961905714377;5459.181122831607;5483.533899618417;5484.478974497416;5499.450054994629;5531.751071201725;5383.353997520323;5402.378726446509;5495.203195536705;5511.338639363302;5513.641613295123;5511.311086114236;5514.972425137848;5515.4760297771645;5534.667919924817;5554.555635549065;5265.236540701653;5382.196964017098;5388.275751759399;5451.64564303319;5453.754581043783;5507.642003269774;5519.9448005521035;5539.446055394428;5544.63959842609;5546.195801608825;5357.92841431723;5370.194470829407;5380.650257733235;5389.595780316414;5398.325209348832 14:24:26 INFO - PROCESS | 16095 | |5;yui.html;735.3198291580287;767.8195624028352;784.2432053068791;842.6797816829604;849.3417601358946;15237.16195609241;15958.601034974103;15998.76001859973;16004.359825606962;16014.519564413056;14754.852451475483;14948.775768363455;14956.102633841978;14957.252137393114;14963.251837408141;455.1079883428484;462.2880763624015;603.9516838652897;823.851706692795;846.1411667157839;842.5281842168374;846.3060290561712;848.6902280667542;849.6941101203562;849.9362547808909;899.2850683706437;899.8155378147496;900.2437952120217;900.5722281916103;902.0348227396688;893.9642414303453;894.2756367342473;894.6466145872377;895.4537731983485;895.7447127568677;656.5076192855358;656.6618191631313;657.0144782825762;658.2430205263937;658.3548122839596;14571;14673.486427974969;15246.39014439421;15279.083255004623;15281.235938203044;14140;14218.573442796733;14340.35468403914;14861.628459288497;14968.775468367983;10692.128877446416;10752.247342686014;10761.354318740823;10827.404492752896;11073.944630276877;3759.285735710206;3801.2777572261184;3825.9617403826164;3846.9615303847163;3882.068303607114;61867.690661546854;63272.68363658198;63625.3637463624;64332.678336608486;64700;9936.50317484123;10020.789814479418;10223.59105635781;10331.94834025825;10367.429791361397;20508.69236961447;21046.579068418545;21222.681659775117;21497.247596334055;21704.89147554252;7418.369438597671;7679;7738.613069346623;7834.451588388758;8298.502089874626;4158.08522125132;4208.326667733148;4262.893427664271;4432.312991486325;4443.888902777457;3456.4815277708544;3484;3499.3876071687355;3575.4815551745373;3575.606683264839;567.6508946997649;572.1417873190214;586.592318338759;593.4807043836643;601.8946684330225;601.5518438763149;625.4683519008806;630.1839118341759;637.91069250305;658.4205898809017;8601.182887625666;8740.956295218482;9366.67216647414;9602.375845570015;9790.706278811647;646.6120327803375;662.9303923088103;663.326723375774;693.774523279936;721.3255606008399;4350.564943505688;4408.140412619572;4544.250198717241;4569.680122391467;4584.564466375689;49240.50759492431;51092;77001;81695.59152204201;82833;70988.2901170992;71979;73236;73282.26717732861;73663.63168184125;52660.73669631627;64250.036249456294;65319.34680653133;65493.345066548725;65600.6719966397;8022.358211343195;8198.467099638505;8280;8319.958400208203;8389.286910612422;33365.666343336256;33750.49374259437;41948.16103677848;43515.78242108769;43532;41765.791171045166;41946;43871.78064109659;57443.425565743804;57693;11918.940405298265;11999.940000299943;12047.939760301142;12089.214201077253;12358.691032724253;12744.235345879277;13089.280089594782;13378.331083445983;13450;13484.595462136152;12427.689307767378;12640.55758048464;12733.808992865299;13421.66445838862;13489.797653035015;12421.75156496883;12471.812922805984;12500;12662.176958497668;12741.235525868478;11356.488957996744;11403.942980285046;11607.76784464323;11679.532818687498;11794.174407791716;9748.073932976356;9945.850812237677;10171.796564068825;10258.948705256425;10789.946050269698;10017.449040302561;10584.417857017937;10623;10693.09108725767;10794.352338859693 14:24:26 INFO - PROCESS | 16095 | __end_tp_report 14:24:26 INFO - PROCESS | 16095 | __start_cc_report 14:24:26 INFO - PROCESS | 16095 | _x_x_mozilla_cycle_collect,1331 14:24:26 INFO - PROCESS | 16095 | __end_cc_report 14:24:26 INFO - PROCESS | 16095 | __startTimestamp1487197466621__endTimestamp 14:24:26 INFO - PROCESS | 16095 | 14:24:26 INFO - PROCESS | 16095 | ------- Summary: start ------- 14:24:26 INFO - PROCESS | 16095 | Number of tests: 6 14:24:26 INFO - PROCESS | 16095 | 14:24:26 INFO - PROCESS | 16095 | [#0] dojo.html Cycles:165 Average:5560.08 Median:5761.97 stddev:614.01 (10.7%) stddev-sans-first:587.95 14:24:26 INFO - PROCESS | 16095 | Values: 3225.9 3238.6 3259.6 3292.4 3312.3 5497.3 5582.6 5590.0 5594.9 5600.5 5612.8 5679.3 5681.9 5688.6 5720.4 5077.1 5129.0 5131.6 5164.2 5206.2 5003.3 5004.6 5218.2 5227.5 5249.4 5011.9 5025.5 5028.9 5109.5 5111.5 5117.4 5194.3 5204.5 5211.2 5237.8 4913.2 4918.4 5114.9 5126.4 5163.3 5468.6 5478.3 5490.8 5493.5 5509.1 6000.3 6046.2 6047.4 6050.4 6052.6 5859.6 5886.0 6078.9 6087.8 6093.5 5518.4 5545.9 5567.8 5613.3 5616.5 6129.8 6133.8 6140.4 6143.9 6147.8 5680.3 5729.5 5899.0 5905.6 5913.4 5897.7 5926.0 5970.1 5976.6 5979.7 5903.6 5904.1 5913.3 5913.4 5920.5 5849.2 5864.8 5911.1 5918.9 5932.5 4634.0 4645.7 4670.9 4672.1 4674.2 4110.9 4119.7 4192.3 4216.0 4224.5 5755.3 5762.0 5767.9 5768.2 5783.7 5999.5 6026.5 6033.5 6041.3 6045.7 5547.1 5590.4 5600.7 5620.0 5774.0 5130.6 5131.8 5136.9 5142.4 5164.7 6201.9 6213.6 6215.5 6220.1 6225.4 5808.4 5815.7 5888.1 5916.9 5972.4 6178.0 6248.0 6288.7 6298.4 6299.0 5897.9 5902.3 5903.1 5908.8 5939.8 5884.0 5940.6 5963.6 5990.0 5998.6 5810.8 5882.6 5900.1 5908.4 5918.4 5822.7 5832.2 5865.4 5878.7 5879.9 5649.8 5656.8 5849.9 5851.0 5857.0 5708.8 5720.7 5740.4 5801.2 5836.7 5664.8 5667.4 5670.6 5672.5 5678.9 14:24:26 INFO - PROCESS | 16095 | 14:24:26 INFO - PROCESS | 16095 | [#1] ext.html Cycles:180 Average:54948.04 Median:37861.93 stddev:102737.86 (271.3%) stddev-sans-first:102944.95 14:24:26 INFO - PROCESS | 16095 | Values: 572.7 575.6 588.1 619.8 643.8 27767.3 38286.8 39030.4 39094.6 39096.6 45643.3 45969.8 46072.3 46086.5 46254.5 7771.1 8872.4 9025.7 9026.5 9027.2 7845.6 10692.6 10899.2 10899.7 11225.4 10580.6 10620.2 10630.8 10636.1 10644.9 10582.6 10610.3 10624.6 10628.7 10638.0 10737.7 10837.0 10837.2 10837.9 10838.1 42232.8 42357.6 42666.8 42680.8 42684.0 3587.4 3706.2 3715.7 4069.7 4235.5 34594.8 34634.0 34682.7 34749.3 34791.8 4511.5 4541.0 4548.9 4552.9 4614.0 320318.0 321752.0 321823.0 322278.0 322351.0 62397.7 63051.0 63109.0 63112.0 63116.7 38827.8 39573.0 39811.8 41482.0 41625.2 15348.7 15564.9 15566.7 15571.4 15575.8 9456.5 9682.6 10290.8 10398.4 10567.6 19508.2 19919.6 19941.3 20002.9 20079.1 7321.0 7321.1 7326.9 7358.3 7602.7 969.2 981.1 1008.3 1058.8 1143.5 30795.4 30822.5 31364.7 32636.0 32976.8 1097.9 1149.6 1153.0 1191.3 1222.0 14731.8 15402.4 15408.6 15475.0 15508.8 453276.0 456022.0 457346.0 457648.0 459453.0 47113.5 47577.8 47638.0 47638.5 47653.3 1033.1 1059.1 1351.1 1423.3 1458.8 28961.4 32329.5 32780.2 32858.3 32908.3 49649.0 50210.7 50238.7 50293.5 50331.2 375671.0 379726.0 380043.0 380081.0 380134.0 22507.8 22950.8 28214.4 29287.6 29338.6 45227.8 45393.5 45505.3 45566.5 45676.0 37245.3 37898.4 38080.6 38640.4 39644.4 38738.6 39208.6 39212.2 39317.0 40580.0 39252.2 39553.0 44325.3 45484.5 45667.3 34731.0 37612.0 37785.0 37785.4 37825.4 33030.7 34907.8 35116.3 35120.5 35149.8 14:24:26 INFO - PROCESS | 16095 | 14:24:26 INFO - PROCESS | 16095 | [#2] jquery.html Cycles:180 Average:27127.42 Median:3138.09 stddev:73372.09 (2338.1%) stddev-sans-first:73550.49 14:24:26 INFO - PROCESS | 16095 | Values: 408.6 423.6 426.5 431.4 436.5 18166.9 18491.4 19551.8 19802.4 19865.7 19303.5 19782.1 19791.7 19826.0 20104.3 5734.8 5841.4 5864.6 5872.2 5880.8 5679.1 5783.3 5818.4 5915.2 5916.9 5804.7 5807.0 5819.8 5822.7 5831.6 5609.1 5729.4 5770.5 5807.4 5809.8 5214.6 5219.2 5223.6 5223.8 5224.9 18812.6 21886.3 22541.7 22788.1 22794.5 2337.0 2441.2 2807.7 3122.8 3153.4 10307.9 10315.5 10600.4 10847.7 10855.1 1954.4 2008.7 2018.8 2031.2 2052.5 64224.4 67727.3 70092.0 75550.2 77400.0 10913.9 10985.7 11343.8 11354.5 11581.8 16696.8 16749.5 16753.6 16764.7 16780.3 7818.1 7827.8 7844.4 7937.1 7976.4 7164.7 7197.6 7440.6 7543.7 7634.1 4974.8 5075.6 5091.5 5116.5 5219.5 1959.9 2036.4 2038.1 2061.3 2065.9 942.6 978.4 1047.1 1053.4 1081.6 18238.4 18608.6 18828.2 19173.3 19536.2 930.2 966.2 1003.2 1014.6 1027.7 10115.0 10747.7 10761.4 10797.3 11058.0 440160.0 440814.0 442006.0 448538.0 449551.0 56123.2 96773.2 97232.0 97234.5 97567.0 995.6 1047.6 1056.2 1058.1 1058.8 16956.0 17424.7 17472.2 17552.0 17817.2 35239.3 37138.8 42520.0 42915.4 43330.6 57676.0 58053.4 59142.0 59270.0 60018.6 7820.5 8005.1 8128.2 8134.2 8318.0 10250.3 11531.5 11899.0 12049.6 12459.6 10311.0 10481.6 10720.2 10900.8 10988.1 4715.9 6038.8 10276.0 10527.2 10555.5 7882.9 10602.2 10617.5 10884.4 11145.9 7853.7 7949.8 8165.2 8291.0 8643.0 10596.5 10625.2 10701.3 10725.4 10832.9 14:24:26 INFO - PROCESS | 16095 | 14:24:26 INFO - PROCESS | 16095 | [#3] mootools.html Cycles:180 Average:5783.97 Median:5038.31 stddev:3323.54 (66.0%) stddev-sans-first:3313.99 14:24:26 INFO - PROCESS | 16095 | Values: 1071.8 1256.0 1369.5 1385.1 1851.0 7402.7 8518.0 8769.6 8769.7 8971.5 8787.8 8868.1 8871.5 8874.6 8881.9 2424.1 2426.0 2451.5 2454.1 2454.4 2389.9 2398.8 2418.4 2447.9 2453.2 2369.8 2379.0 2403.3 2406.4 2411.3 2283.9 2288.1 2308.9 2309.0 2317.3 2306.1 2309.7 2334.6 2335.7 2336.3 8715.1 8819.6 8873.5 8894.8 8946.6 5422.8 5554.3 5576.8 5580.2 5592.3 3335.8 3432.3 3453.9 3459.2 3490.7 1103.9 1112.6 1129.5 1158.3 1167.5 12486.1 12532.6 12580.3 12586.1 12602.9 4298.4 4578.5 4611.0 4647.5 4667.5 9828.2 9832.1 9834.8 9840.9 9842.3 5417.6 5421.8 5422.8 5423.3 5426.4 4076.2 4254.6 4297.5 4319.2 5088.3 3862.8 3901.5 4008.4 4029.1 4029.1 1172.5 1173.0 1176.5 1196.0 1226.8 826.4 832.1 885.0 892.2 975.5 5818.1 5871.2 5892.2 5919.0 6104.9 865.8 874.9 898.5 965.8 978.3 3716.8 3834.4 3851.1 3865.8 3891.0 10759.4 11208.8 11217.5 11273.9 11281.2 11150.8 11160.9 11163.0 11167.4 11171.2 8000.4 8326.5 8328.0 8391.6 8521.7 5549.3 5712.4 5722.4 5820.6 5848.8 9834.5 10102.5 10137.1 10141.2 10154.3 9168.5 9454.4 10105.5 10268.2 10368.8 7614.6 7911.7 7915.3 7979.4 8095.2 8668.6 8681.7 8742.6 8776.8 8780.6 7533.4 7586.4 7722.5 7734.4 7767.8 7544.8 7601.4 7622.4 7635.2 7883.3 6806.9 6913.4 6919.0 6919.4 6924.9 5007.8 5068.8 5071.8 5083.1 5295.9 4757.2 4796.8 4869.0 4964.2 5069.1 14:24:26 INFO - PROCESS | 16095 | 14:24:26 INFO - PROCESS | 16095 | [#4] prototype.html Cycles:180 Average:4627.77 Median:5269.07 stddev:1329.67 (25.2%) stddev-sans-first:1294.03 14:24:26 INFO - PROCESS | 16095 | Values: 348.8 349.5 354.2 355.2 361.6 5174.9 5214.5 5360.9 5373.5 5383.9 5092.9 5212.9 5234.7 5265.7 5272.4 4189.8 4213.9 4218.4 4222.7 4292.0 4004.8 4201.0 4240.7 4249.0 4296.7 4175.1 4181.2 4187.8 4191.8 4198.5 4153.9 4174.0 4175.3 4178.1 4201.8 3734.9 3744.8 3745.6 3751.1 3757.7 5028.4 5086.7 5144.0 5145.9 5161.4 4743.2 4750.5 4757.0 4759.8 4772.7 5442.7 5453.7 5498.4 5499.6 5525.1 3959.4 4014.4 4035.6 4047.4 4056.3 5631.0 5666.0 5676.9 5677.5 5700.8 4136.3 4152.5 4156.3 4161.8 4173.1 4007.9 4165.6 4167.6 4170.6 4230.7 4659.6 4704.5 4708.1 4709.3 4726.9 5505.9 5530.6 5538.6 5552.3 5554.8 1314.1 1329.3 1337.7 1380.9 1393.0 961.8 974.6 975.2 978.9 988.3 5205.9 5226.5 5230.7 5235.3 5239.3 5471.9 5472.5 5477.5 5526.9 5545.6 5179.6 5215.4 5226.8 5228.2 5462.7 2876.5 2891.7 2929.6 2933.0 2953.3 5694.7 5716.5 5734.0 5740.9 5753.2 5421.1 5526.5 5529.5 5546.8 5595.1 5679.9 5682.3 5684.5 5709.1 5709.6 5292.4 5444.5 5458.8 5487.5 5502.3 5417.7 5458.7 5467.8 5471.7 5474.3 5701.9 5772.9 5773.3 5779.7 5783.3 3895.6 3998.4 4012.4 4019.5 4025.4 5459.2 5483.5 5484.5 5499.5 5531.8 5383.4 5402.4 5495.2 5511.3 5513.6 5511.3 5515.0 5515.5 5534.7 5554.6 5265.2 5382.2 5388.3 5451.6 5453.8 5507.6 5519.9 5539.4 5544.6 5546.2 5357.9 5370.2 5380.7 5389.6 5398.3 14:24:26 INFO - PROCESS | 16095 | 14:24:26 INFO - PROCESS | 16095 | [#5] yui.html Cycles:180 Average:16349.62 Median:4438.10 stddev:20725.08 (467.0%) stddev-sans-first:20750.05 14:24:26 INFO - PROCESS | 16095 | Values: 735.3 767.8 784.2 842.7 849.3 15237.2 15958.6 15998.8 16004.4 16014.5 14754.9 14948.8 14956.1 14957.3 14963.3 455.1 462.3 604.0 823.9 846.1 842.5 846.3 848.7 849.7 849.9 899.3 899.8 900.2 900.6 902.0 894.0 894.3 894.6 895.5 895.7 656.5 656.7 657.0 658.2 658.4 14571.0 14673.5 15246.4 15279.1 15281.2 14140.0 14218.6 14340.4 14861.6 14968.8 10692.1 10752.2 10761.4 10827.4 11073.9 3759.3 3801.3 3826.0 3847.0 3882.1 61867.7 63272.7 63625.4 64332.7 64700.0 9936.5 10020.8 10223.6 10331.9 10367.4 20508.7 21046.6 21222.7 21497.2 21704.9 7418.4 7679.0 7738.6 7834.5 8298.5 4158.1 4208.3 4262.9 4432.3 4443.9 3456.5 3484.0 3499.4 3575.5 3575.6 567.7 572.1 586.6 593.5 601.9 601.6 625.5 630.2 637.9 658.4 8601.2 8741.0 9366.7 9602.4 9790.7 646.6 662.9 663.3 693.8 721.3 4350.6 4408.1 4544.3 4569.7 4584.6 49240.5 51092.0 77001.0 81695.6 82833.0 70988.3 71979.0 73236.0 73282.3 73663.6 52660.7 64250.0 65319.3 65493.3 65600.7 8022.4 8198.5 8280.0 8320.0 8389.3 33365.7 33750.5 41948.2 43515.8 43532.0 41765.8 41946.0 43871.8 57443.4 57693.0 11918.9 11999.9 12047.9 12089.2 12358.7 12744.2 13089.3 13378.3 13450.0 13484.6 12427.7 12640.6 12733.8 13421.7 13489.8 12421.8 12471.8 12500.0 12662.2 12741.2 11356.5 11403.9 11607.8 11679.5 11794.2 9748.1 9945.9 10171.8 10258.9 10789.9 10017.4 10584.4 10623.0 10693.1 10794.4 14:24:26 INFO - PROCESS | 16095 | -------- Summary: end -------- 14:24:26 INFO - PROCESS | 16095 | 14:24:27 INFO - TEST-INFO | 16095: exit 0 14:24:27 INFO - TEST-OK | dromaeo_css | took 1115068ms 14:24:27 INFO - TEST-START | kraken 14:24:27 INFO - operating with platform_type : linux_ 14:24:27 INFO - Initialising browser for kraken test... 14:24:27 INFO - TEST-INFO | started process 16397 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZHJwbN/profile http://localhost:52808/getInfo.html) 14:24:31 INFO - PROCESS | 16397 | __metrics Screen width/height:1600/1200 14:24:31 INFO - PROCESS | 16397 | colorDepth:24 14:24:31 INFO - PROCESS | 16397 | Browser inner width/height: 1024/697 14:24:31 INFO - PROCESS | 16397 | __metrics 14:24:32 INFO - PROCESS | 16397 | 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" 14:24:32 INFO - PROCESS | 16397 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:24:32 INFO - PROCESS | 16397 | console.error: PushService: 14:24:32 INFO - PROCESS | 16397 | stateChangeProcessEnqueue: Error transitioning state 14:24:32 INFO - PROCESS | 16397 | UnknownError 14:24:33 INFO - TEST-INFO | 16397: exit 0 14:24:33 INFO - Browser initialized. 14:24:33 INFO - Running cycle 1/1 for kraken test... 14:24:33 INFO - TEST-INFO | started process 16487 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZHJwbN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:24:45 INFO - PROCESS | 16487 | RSS: Main: 144941056 14:24:45 INFO - PROCESS | 16487 | 14:24:47 INFO - PROCESS | 16487 | Cycle 1(1): loaded http://localhost:52808/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52808/tests/kraken/driver.html?testName=audio-beat-detection) 14:24:48 INFO - PROCESS | 16487 | RSS: Main: 186204160 14:24:48 INFO - PROCESS | 16487 | 14:24:51 INFO - PROCESS | 16487 | Cycle 1(1): loaded http://localhost:52808/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52808/tests/kraken/driver.html?testName=audio-dft) 14:24:51 INFO - PROCESS | 16487 | RSS: Main: 176459776 14:24:51 INFO - PROCESS | 16487 | 14:24:54 INFO - PROCESS | 16487 | Cycle 1(1): loaded http://localhost:52808/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52808/tests/kraken/driver.html?testName=audio-fft) 14:24:55 INFO - PROCESS | 16487 | RSS: Main: 267653120 14:24:55 INFO - PROCESS | 16487 | 14:24:57 INFO - PROCESS | 16487 | Cycle 1(1): loaded http://localhost:52808/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52808/tests/kraken/driver.html?testName=audio-oscillator) 14:24:57 INFO - PROCESS | 16487 | RSS: Main: 174387200 14:24:57 INFO - PROCESS | 16487 | 14:24:59 INFO - PROCESS | 16487 | Cycle 1(1): loaded http://localhost:52808/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52808/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:25:00 INFO - PROCESS | 16487 | RSS: Main: 176275456 14:25:00 INFO - PROCESS | 16487 | 14:25:03 INFO - PROCESS | 16487 | Cycle 1(1): loaded http://localhost:52808/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52808/tests/kraken/driver.html?testName=imaging-darkroom) 14:25:03 INFO - PROCESS | 16487 | RSS: Main: 214970368 14:25:03 INFO - PROCESS | 16487 | 14:25:07 INFO - PROCESS | 16487 | Cycle 1(1): loaded http://localhost:52808/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52808/tests/kraken/driver.html?testName=imaging-desaturate) 14:25:07 INFO - PROCESS | 16487 | RSS: Main: 213389312 14:25:07 INFO - PROCESS | 16487 | 14:25:10 INFO - PROCESS | 16487 | Cycle 1(1): loaded http://localhost:52808/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52808/tests/kraken/driver.html?testName=json-parse-financial) 14:25:11 INFO - PROCESS | 16487 | RSS: Main: 212512768 14:25:11 INFO - PROCESS | 16487 | 14:25:12 INFO - PROCESS | 16487 | Cycle 1(1): loaded http://localhost:52808/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52808/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:25:13 INFO - PROCESS | 16487 | RSS: Main: 174784512 14:25:13 INFO - PROCESS | 16487 | 14:25:14 INFO - PROCESS | 16487 | Cycle 1(1): loaded http://localhost:52808/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52808/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:25:15 INFO - PROCESS | 16487 | RSS: Main: 181813248 14:25:15 INFO - PROCESS | 16487 | 14:25:17 INFO - PROCESS | 16487 | Cycle 1(1): loaded http://localhost:52808/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52808/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:25:18 INFO - PROCESS | 16487 | RSS: Main: 188907520 14:25:18 INFO - PROCESS | 16487 | 14:25:20 INFO - PROCESS | 16487 | Cycle 1(1): loaded http://localhost:52808/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52808/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:25:21 INFO - PROCESS | 16487 | RSS: Main: 196620288 14:25:21 INFO - PROCESS | 16487 | 14:25:23 INFO - PROCESS | 16487 | Cycle 1(1): loaded http://localhost:52808/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52808/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:25:24 INFO - PROCESS | 16487 | RSS: Main: 193003520 14:25:24 INFO - PROCESS | 16487 | 14:25:26 INFO - PROCESS | 16487 | Cycle 1(1): loaded http://localhost:52808/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52808/tests/kraken/driver.html?testName=ai-astar) 14:25:26 INFO - PROCESS | 16487 | RSS: Main: 244465664 14:25:26 INFO - PROCESS | 16487 | 14:25:26 INFO - PROCESS | 16487 | __start_tp_report 14:25:26 INFO - PROCESS | 16487 | _x_x_mozilla_page_load 14:25:26 INFO - PROCESS | 16487 | _x_x_mozilla_page_load_details 14:25:26 INFO - PROCESS | 16487 | |i|pagename|runs| 14:25:26 INFO - PROCESS | 16487 | |0;ai-astar;104;111;111;109;111;111;114;112;111;110 14:25:26 INFO - PROCESS | 16487 | |1;audio-beat-detection;142;118;117;161;124;118;123;117;143;118 14:25:26 INFO - PROCESS | 16487 | |2;audio-dft;167;159;161;159;161;161;159;160;159;159 14:25:26 INFO - PROCESS | 16487 | |3;audio-fft;74;75;75;114;76;76;75;75;95;74 14:25:26 INFO - PROCESS | 16487 | |4;audio-oscillator;81;81;124;82;82;82;102;82;81;118 14:25:26 INFO - PROCESS | 16487 | |5;imaging-gaussian-blur;116;117;116;118;117;116;117;116;117;117 14:25:26 INFO - PROCESS | 16487 | |6;imaging-darkroom;145;146;146;146;147;146;147;145;146;146 14:25:26 INFO - PROCESS | 16487 | |7;imaging-desaturate;84;84;84;85;85;85;84;84;85;85 14:25:26 INFO - PROCESS | 16487 | |8;json-parse-financial;51;51;52;51;50;53;49;50;50;49 14:25:26 INFO - PROCESS | 16487 | |9;json-stringify-tinderbox;59;60;59;61;60;59;59;60;59;60 14:25:26 INFO - PROCESS | 16487 | |10;stanford-crypto-aes;74;74;75;74;86;77;75;79;74;81 14:25:26 INFO - PROCESS | 16487 | |11;stanford-crypto-ccm;131;127;130;128;121;121;131;122;174;122 14:25:26 INFO - PROCESS | 16487 | |12;stanford-crypto-pbkdf2;163;159;161;161;161;160;157;159;159;162 14:25:26 INFO - PROCESS | 16487 | |13;stanford-crypto-sha256-iterative;66;63;64;62;62;63;61;63;62;61 14:25:26 INFO - PROCESS | 16487 | __end_tp_report 14:25:26 INFO - PROCESS | 16487 | __start_cc_report 14:25:26 INFO - PROCESS | 16487 | _x_x_mozilla_cycle_collect,1599 14:25:26 INFO - PROCESS | 16487 | __end_cc_report 14:25:26 INFO - PROCESS | 16487 | __startTimestamp1487197526541__endTimestamp 14:25:26 INFO - PROCESS | 16487 | 14:25:26 INFO - PROCESS | 16487 | ------- Summary: start ------- 14:25:26 INFO - PROCESS | 16487 | Number of tests: 14 14:25:26 INFO - PROCESS | 16487 | 14:25:26 INFO - PROCESS | 16487 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.59 (2.3%) stddev-sans-first:1.36 14:25:26 INFO - PROCESS | 16487 | Values: 104.0 111.0 111.0 109.0 111.0 111.0 114.0 112.0 111.0 110.0 14:25:26 INFO - PROCESS | 16487 | 14:25:26 INFO - PROCESS | 16487 | [#1] audio-beat-detection Cycles:10 Average:128.10 Median:123.50 stddev:15.25 (12.3%) stddev-sans-first:15.32 14:25:26 INFO - PROCESS | 16487 | Values: 142.0 118.0 117.0 161.0 124.0 118.0 123.0 117.0 143.0 118.0 14:25:26 INFO - PROCESS | 16487 | 14:25:26 INFO - PROCESS | 16487 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:2.46 (1.5%) stddev-sans-first:0.97 14:25:26 INFO - PROCESS | 16487 | Values: 167.0 159.0 161.0 159.0 161.0 161.0 159.0 160.0 159.0 159.0 14:25:26 INFO - PROCESS | 16487 | 14:25:26 INFO - PROCESS | 16487 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:13.24 (17.6%) stddev-sans-first:13.80 14:25:26 INFO - PROCESS | 16487 | Values: 74.0 75.0 75.0 114.0 76.0 76.0 75.0 75.0 95.0 74.0 14:25:26 INFO - PROCESS | 16487 | 14:25:26 INFO - PROCESS | 16487 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:81.50 stddev:16.87 (20.7%) stddev-sans-first:17.46 14:25:26 INFO - PROCESS | 16487 | Values: 81.0 81.0 124.0 82.0 82.0 82.0 102.0 82.0 81.0 118.0 14:25:26 INFO - PROCESS | 16487 | 14:25:26 INFO - PROCESS | 16487 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 14:25:26 INFO - PROCESS | 16487 | Values: 116.0 117.0 116.0 118.0 117.0 116.0 117.0 116.0 117.0 117.0 14:25:26 INFO - PROCESS | 16487 | 14:25:26 INFO - PROCESS | 16487 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 14:25:26 INFO - PROCESS | 16487 | Values: 145.0 146.0 146.0 146.0 147.0 146.0 147.0 145.0 146.0 146.0 14:25:26 INFO - PROCESS | 16487 | 14:25:26 INFO - PROCESS | 16487 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 14:25:26 INFO - PROCESS | 16487 | Values: 84.0 84.0 84.0 85.0 85.0 85.0 84.0 84.0 85.0 85.0 14:25:26 INFO - PROCESS | 16487 | 14:25:26 INFO - PROCESS | 16487 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:51.00 stddev:1.26 (2.5%) stddev-sans-first:1.33 14:25:26 INFO - PROCESS | 16487 | Values: 51.0 51.0 52.0 51.0 50.0 53.0 49.0 50.0 50.0 49.0 14:25:26 INFO - PROCESS | 16487 | 14:25:26 INFO - PROCESS | 16487 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 14:25:26 INFO - PROCESS | 16487 | Values: 59.0 60.0 59.0 61.0 60.0 59.0 59.0 60.0 59.0 60.0 14:25:26 INFO - PROCESS | 16487 | 14:25:26 INFO - PROCESS | 16487 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:76.00 stddev:4.01 (5.3%) stddev-sans-first:4.12 14:25:26 INFO - PROCESS | 16487 | Values: 74.0 74.0 75.0 74.0 86.0 77.0 75.0 79.0 74.0 81.0 14:25:26 INFO - PROCESS | 16487 | 14:25:26 INFO - PROCESS | 16487 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:129.00 stddev:15.76 (12.2%) stddev-sans-first:16.72 14:25:26 INFO - PROCESS | 16487 | Values: 131.0 127.0 130.0 128.0 121.0 121.0 131.0 122.0 174.0 122.0 14:25:26 INFO - PROCESS | 16487 | 14:25:26 INFO - PROCESS | 16487 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:161.00 stddev:1.75 (1.1%) stddev-sans-first:1.54 14:25:26 INFO - PROCESS | 16487 | Values: 163.0 159.0 161.0 161.0 161.0 160.0 157.0 159.0 159.0 162.0 14:25:26 INFO - PROCESS | 16487 | 14:25:26 INFO - PROCESS | 16487 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.49 (2.4%) stddev-sans-first:1.00 14:25:26 INFO - PROCESS | 16487 | Values: 66.0 63.0 64.0 62.0 62.0 63.0 61.0 63.0 62.0 61.0 14:25:26 INFO - PROCESS | 16487 | -------- Summary: end -------- 14:25:26 INFO - PROCESS | 16487 | 14:25:27 INFO - TEST-INFO | 16487: exit 0 14:25:27 INFO - TEST-OK | kraken | took 60267ms 14:25:27 INFO - SUITE-END | took 1175s 14:25:27 INFO - Completed test suite (00:19:35) 14:25:27 INFO - javascript benchmark 14:25:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3225.854836532356, 3238.6275578308487, 3259.55995940548, 3292.407366673998, 3312.2878581105056, 5497.285352904122, 5582.637128586644, 5590.0, 5594.944050559493, 5600.523955463786, 5612.831615051555, 5679.290088738908, 5681.914771278423, 5688.63023903446, 5720.427957204278, 5077.111505486543, 5129.0, 5131.634099119776, 5164.2253661950635, 5206.245094461301, 5003.274525193845, 5004.624653151028, 5218.1650935850275, 5227.47725227478, 5249.370075590934, 5011.949880501184, 5025.472325405834, 5028.899422011557, 5109.514596113363, 5111.488851114877, 5117.385913690362, 5194.298769666122, 5204.479552044765, 5211.166213405856, 5237.8428647140645, 4913.238448040559, 4918.385201849769, 5114.923276150861, 5126.384833819928, 5163.302954101224, 5468.562514998791, 5478.342598888159, 5490.752916118784, 5493.450654934514, 5509.118541033456, 6000.279966404016, 6046.183765191687, 6047.395260473962, 6050.394960503959, 6052.636841789506, 5859.6191247569195, 5886.028805247129, 6078.939210607926, 6087.786927457518, 6093.512518998469, 5518.392976772552, 5545.861353466155, 5567.832965011056, 5613.298337707786, 5616.494515493625, 6129.816105516842, 6133.846653833601, 6140.3552626974415, 6143.907841382383, 6147.784827531015, 5680.261565996394, 5729.541636669056, 5899.0, 5905.557083218776, 5913.408659134052, 5897.675627840425, 5925.970370148121, 5970.104484327298, 5976.551758618121, 5979.701014949235, 5903.645781253139, 5904.143899134601, 5913.29040515141, 5913.408659134052, 5920.496757775637, 5849.181114643953, 5864.7947321844385, 5911.142884281755, 5918.8816223675285, 5932.466078052909, 4634.0, 4645.6980296280635, 4670.929936050962, 4672.065586882637, 4674.182018146811, 4110.8561200358445, 4119.732217405919, 4192.266353388145, 4216.030313028021, 4224.45082139326, 5755.309362876482, 5761.971190144106, 5767.8558036049435, 5768.221290125864, 5783.652980821164, 5999.490043346277, 6026.5178785697035, 6033.4871535919065, 6041.275046994301, 6045.667488288186, 5547.084731019418, 5590.357108932443, 5600.663960162403, 5620.044592419298, 5774.04728219839, 5130.589552835764, 5131.846044618667, 5136.948630513722, 5142.382914050338, 5164.664296820694, 6201.937980620226, 6213.627182369072, 6215.471684906834, 6220.066989951543, 6225.408586184305, 5808.39011903744, 5815.651060936358, 5888.116782482662, 5916.911246331222, 5972.372900845348, 6177.96911015442, 6248.031555108783, 6288.748450061947, 6298.433141017331, 6299.023651333867, 5897.882042359043, 5902.2622172228475, 5903.144044113494, 5908.813018475057, 5939.7921072763975, 5883.970580147243, 5940.584159108821, 5963.642181469126, 5990.0, 5998.550108741949, 5810.82567522975, 5882.558808089325, 5900.085486749561, 5908.379620139824, 5918.40815918422, 5822.650640961556, 5832.24180856486, 5865.384134665969, 5878.676672783038, 5879.882402351844, 5649.802256921153, 5656.830295091154, 5849.853753656193, 5851.034579294369, 5856.970715146397, 5708.828735137952, 5720.713964301685, 5740.425957404226, 5801.1878337033695, 5836.678982655994, 5664.830055098354, 5667.40492248308, 5670.631408958405, 5672.4894759471845, 5678.858028549319], "value": 5519.923571642868, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.687885102619, 575.6028340445096, 588.0591054313097, 619.8202521268832, 643.7746788623982, 27767.30581735455, 38286.808565957166, 39030.41454378179, 39094.60905390945, 39096.609033909685, 45643.315350269775, 45969.7701511492, 46072.308915366295, 46086.53913460873, 46254.537454625446, 7771.106322772869, 8872.423292485984, 9025.684101056464, 9026.458412495238, 9027.232685221765, 7845.568493732842, 10692.625758098467, 10899.182561307895, 10899.673009809718, 11225.438728063606, 10580.576776928914, 10620.150387968944, 10630.78738425231, 10636.095931845803, 10644.882287359831, 10582.629607963685, 10610.257281990263, 10624.57501699935, 10628.734281642983, 10638.0, 10737.731556711145, 10837.0, 10837.241393102486, 10837.891621083767, 10838.078763305128, 42232.78883605593, 42357.576424235674, 42666.78666606647, 42680.78659606713, 42684.0, 3587.3722098632634, 3706.166112624665, 3715.702743780518, 4069.651938970116, 4235.4917409911, 34594.827025864965, 34634.0, 34682.65317346819, 34749.30501389983, 34791.826040869884, 4511.547413021399, 4540.954590454086, 4548.909021819578, 4552.8861778455475, 4613.953860461386, 320318.0, 321751.9999999977, 321823.0, 322278.0, 322351.0, 62397.68801155965, 63051.0, 63109.0, 63112.0, 63116.68441657762, 38827.80586097051, 39573.0, 39811.80094099569, 41482.0, 41625.1674966499, 15348.693026139415, 15564.92217538905, 15566.688666226839, 15571.377144914077, 15575.76636350433, 9456.527173641429, 9682.56428460721, 10290.845637315446, 10398.376097434179, 10567.577296908192, 19508.219671213275, 19919.60160796776, 19941.302054428026, 20002.89998549998, 20079.096440660207, 7321.048263725788, 7321.059919121437, 7326.9267307326245, 7358.300961408658, 7602.657880395395, 969.2149359019216, 981.087588542648, 1008.3193844155165, 1058.8147074262126, 1143.4854315557866, 30795.38409231803, 30822.53766193509, 31364.686353136178, 32636.02091937246, 32976.835115824266, 1097.9066779323846, 1149.6091328948198, 1152.9654110376703, 1191.3209470601846, 1222.0468034932767, 14731.779023314659, 15402.383904643688, 15408.614784630474, 15475.0, 15508.844911550967, 453276.0, 456022.0, 457346.0, 457648.0, 459453.0, 47113.52886471091, 47577.76211118922, 47638.0, 47638.523614764104, 47653.28520072201, 1033.1115240892825, 1059.0786016165985, 1351.115019662123, 1423.3025817349424, 1458.7811828225638, 28961.42077158487, 32329.51505727463, 32780.1804954878, 32858.34283314368, 32908.34183316368, 49649.0, 50210.74894625504, 50238.74880625573, 50293.49706502888, 50331.24503132383, 375671.0, 379726.0, 380043.0, 380081.0, 380134.0, 22507.774922250566, 22950.77049229553, 28214.43571128525, 29287.56068658929, 29338.559921600765, 45227.77386113048, 45393.546064540256, 45505.317420239386, 45566.544334557555, 45676.0, 37245.25509489849, 37898.43152352662, 38080.619193808816, 38640.42039369468, 39644.40533392059, 38738.6126138735, 39208.607913920496, 39212.2157556853, 39317.0, 40580.0, 39252.214955700154, 39553.011174720865, 44325.33511997387, 45484.545154549356, 45667.314990274506, 34731.0, 37612.0, 37785.0, 37785.433218502294, 37825.432618511295, 33030.669693302756, 34907.82546087253, 35116.29767404586, 35120.47319290161, 35149.824250878584], "value": 19856.305019754418, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.583245090008, 423.5806551514002, 426.48821414302836, 431.4451963027274, 436.4871276250406, 18166.90916545417, 18491.352802651894, 19551.804481955176, 19802.405927822154, 19865.702014469796, 19303.517412064706, 19782.10980505877, 19791.703124453146, 19826.008699565, 20104.296349627766, 5734.770609175638, 5841.386654401291, 5864.648121112726, 5872.207252020987, 5880.8235752927485, 5679.148127780824, 5783.277090363705, 5818.359980402152, 5915.231019967398, 5916.911246331309, 5804.709764511778, 5806.9709651451685, 5819.82540523785, 5822.650640961556, 5831.591788574801, 5609.102543593026, 5729.427057294279, 5770.451807078321, 5807.41925807418, 5809.7676092956235, 5214.556762675177, 5219.243209734567, 5223.608229382773, 5223.791048358061, 5224.895502089975, 18812.623747524973, 21886.343409697736, 22541.661875071888, 22788.08847646092, 22794.54410911789, 2336.9532609347716, 2441.182203961675, 2807.73326533981, 3122.78140530163, 3153.4008538377866, 10307.875657960061, 10315.484225788756, 10600.363978161335, 10847.67456976292, 10855.077318427942, 1954.355062829263, 2008.7288216090788, 2018.8082132197417, 2031.1976769176092, 2052.5176583502866, 64224.3577564223, 67727.32272677259, 70092.0, 75550.24449755487, 77400.0, 10913.945430272957, 10985.725356865982, 11343.829842552368, 11354.48904799286, 11581.76836463266, 16696.83303166953, 16749.497515074567, 16753.581160470843, 16764.748528772077, 16780.32878684839, 7818.100918394343, 7827.765167044884, 7844.37245020397, 7937.126916039231, 7976.361891048702, 7164.749233776793, 7197.568145911262, 7440.590767507731, 7543.698252069966, 7634.083909930733, 4974.7512624369365, 5075.568576671024, 5091.516305950929, 5116.462771409023, 5219.5041471060185, 1959.8726082804571, 2036.3890832750117, 2038.1134206619872, 2061.3197644777188, 2065.865718728278, 942.6465075596651, 978.3689520259393, 1047.1413440978324, 1053.441675911768, 1081.605214096849, 18238.41641058389, 18608.627827443375, 18828.246870125316, 19173.32893348726, 19536.21855125779, 930.2186163622589, 966.2270183852889, 1003.2325271167563, 1014.5688082564881, 1027.6505987964129, 10115.0, 10747.677569672922, 10761.408122553177, 10797.29817561856, 11058.0, 440160.0, 440814.0, 442006.0, 448538.0, 449551.0, 56123.158152627744, 96773.16134193403, 97232.0, 97234.5138274304, 97567.0, 995.6365926436944, 1047.6280920273346, 1056.1550759392455, 1058.0583280880023, 1058.7564860082225, 16956.0, 17424.738628920324, 17472.213750381008, 17552.0, 17817.1982260796, 35239.295214096084, 37138.814305928296, 42520.0, 42915.356269655356, 43330.56669433265, 57676.0, 58053.4194658048, 59142.0, 59270.0, 60018.59925602927, 7820.491668041559, 8005.079415867017, 8128.187181281824, 8134.227248411392, 8318.0, 10250.282480226313, 11531.481083351437, 11899.0, 12049.638510844688, 12459.563915262923, 10311.020453056948, 10481.58073677075, 10720.249582529148, 10900.836487452852, 10988.120950324115, 4715.882102947454, 6038.849028774316, 10276.0, 10527.210459215436, 10555.472226388496, 7882.881756773539, 10602.20483463728, 10617.522211500347, 10884.40135792539, 11145.888541114486, 7853.725119620786, 7949.8410031800195, 8165.183481651788, 8290.958545207235, 8642.956785216034, 10596.47017649099, 10625.203109766644, 10701.304415213297, 10725.410102444128, 10832.945835270773], "value": 9037.552736623706, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1071.8499410082595, 1256.0265794009645, 1369.5001324516554, 1385.127369757053, 1850.9537261568466, 7402.6668799904, 8518.0, 8769.60536775845, 8769.693060742859, 8971.506567138806, 8787.824243515126, 8868.068852770462, 8871.467711937272, 8874.55627218638, 8881.911180888206, 2424.1151979527476, 2426.0349117215023, 2451.4974430241846, 2454.1165180534995, 2454.447749256421, 2389.880505974694, 2398.8080953523677, 2418.3833122553724, 2447.877606119696, 2453.2272334214754, 2369.7985671217966, 2378.9643155352683, 2403.3390817525233, 2406.42245860993, 2411.3127758588807, 2283.8515496492673, 2288.119074156445, 2308.9307320780404, 2309.030207312924, 2317.2584772872688, 2306.0545176477563, 2309.6535519672016, 2334.6381310896836, 2335.719713634358, 2336.3107883174503, 8715.084916083782, 8819.559022048936, 8873.467591944504, 8894.777630559223, 8946.552672366355, 5422.8373148805595, 5554.250176226198, 5576.776928922838, 5580.246666699984, 5592.273004509429, 3335.816530090844, 3432.3478539077496, 3453.9465463033766, 3459.2043829919257, 3490.7381946354126, 1103.9227254092216, 1112.6383925224334, 1129.5425352732075, 1158.322381406878, 1167.5038108803724, 12486.12597118202, 12532.624021279376, 12580.308083055428, 12586.056045796602, 12602.873971260262, 4298.4197133387215, 4578.5421457853945, 4611.0, 4647.488776234612, 4667.463241727177, 9828.164606008426, 9832.115109640166, 9834.80330393388, 9840.901590983998, 9842.311038227255, 5417.647852889629, 5421.756020979065, 5422.8373148805595, 5423.29497165366, 5426.430224826416, 4076.164386300801, 4254.574542545783, 4297.54875738043, 4319.200947824663, 5088.338515992898, 3862.8261728222296, 3901.4733011043713, 4008.398740188995, 4029.0531725044593, 4029.1135950090934, 1172.5192671005018, 1172.9824052639217, 1176.5235079792697, 1195.9714645404945, 1226.8405107336168, 826.3636999510344, 832.0597724571317, 884.9645914280308, 892.2326798952895, 975.4829940131741, 5818.080033588905, 5871.178035075093, 5892.204552385373, 5919.0, 6104.938950610526, 865.8138500222483, 874.8818909447143, 898.4743924803932, 965.8406362950175, 978.2614126334572, 3716.758410703296, 3834.386498160281, 3851.056491159684, 3865.8260378283044, 3890.9610903891166, 10759.3544387337, 11208.775824483464, 11217.495212715447, 11273.887261127447, 11281.153913456523, 11150.776984460266, 11160.944195278971, 11163.0, 11167.441627918572, 11171.21801473889, 8000.399970002273, 8326.50040997542, 8327.958360208282, 8391.580420978926, 8521.659133634708, 5549.278593782782, 5712.400197979318, 5722.4277572242445, 5820.592558520862, 5848.766049357978, 9834.459104749021, 10102.494875256061, 10137.087662110445, 10141.239407044648, 10154.339967902062, 9168.495732734764, 9454.385464944757, 10105.494725263561, 10268.178545716175, 10368.844467332845, 7614.581198034161, 7911.683532658629, 7915.287624113857, 7979.441439099207, 8095.190480952093, 8668.609912553824, 8681.696140635047, 8742.606582703665, 8776.824463510566, 8780.604872780612, 7533.359664428585, 7586.393088553013, 7722.5366478009255, 7734.419918506022, 7767.844643107219, 7544.8491030180185, 7601.3918886490055, 7622.390208783395, 7635.198304178203, 7883.251091146332, 6806.93193068063, 6913.446924246149, 6919.031335613119, 6919.411849992807, 6924.930750692429, 5007.799688012438, 5068.82259120929, 5071.771770270273, 5083.1358669027095, 5295.920561191509, 4757.238841785298, 4796.760161991817, 4869.0, 4964.230544265644, 5069.087564238473], "value": 4600.391876303648, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.8290737538607, 349.5089399393851, 354.18890740204915, 355.2167470727047, 361.625717382509, 5174.861530463292, 5214.530692237698, 5360.892782144355, 5373.489518495741, 5383.89232215356, 5092.911906118492, 5212.8696782580455, 5234.7120908350025, 5265.684058956465, 5272.446393128724, 4189.811458484361, 4213.936790948138, 4218.367244913257, 4222.662187025046, 4292.034292284242, 4004.7985604318587, 4200.957990420087, 4240.681948853833, 4248.9575104249025, 4296.677749168809, 4175.100329350138, 4181.247375472413, 4187.769672668002, 4191.81136848841, 4198.496180458334, 4153.937690934638, 4173.975621823429, 4175.269327867611, 4178.080822219107, 4201.810918508644, 3734.8879533614036, 3744.7753134811996, 3745.6441638044616, 3751.0997360633523, 3757.6618104370464, 5028.446870844205, 5086.72831792052, 5144.0, 5145.945081258333, 5161.3806343238675, 4743.169945259566, 4750.548697873696, 4756.976215118937, 4759.785809638574, 4772.689775164603, 5442.729086130353, 5453.727313634342, 5498.367687715924, 5499.587530935196, 5525.11598144299, 3959.3665013597974, 4014.3978403239457, 4035.556088830226, 4047.392891066334, 4056.290149223874, 5630.971845140789, 5665.971670141664, 5676.943230567683, 5677.460641239076, 5700.828975130753, 4136.338185890303, 4152.460180176618, 4156.314208155621, 4161.791910404468, 4173.078844808646, 4007.937896457441, 4165.645920096765, 4167.604077612622, 4170.645495132887, 4230.682698797603, 4659.603933665609, 4704.458987216445, 4708.128996135726, 4709.270063140219, 4726.858194254178, 5505.944940550623, 5530.55755539564, 5538.612297139242, 5552.305961754781, 5554.833354999357, 1314.0604467805374, 1329.335332333833, 1337.6789570503204, 1380.9171449713049, 1392.9512467063605, 961.7595601099725, 974.5809302000208, 975.22956864078, 978.8923218445965, 988.3081842710131, 5205.895882082413, 5226.451222621646, 5230.712310822865, 5235.345581802275, 5239.318888544465, 5471.890562188813, 5472.452754724496, 5477.507024367826, 5526.861828454241, 5545.639533430314, 5179.61152913533, 5215.357162493802, 5226.790928362823, 5228.215767634885, 5462.7268636568015, 2876.467853447119, 2891.715544719648, 2929.5898574199628, 2933.0, 2953.3354995126356, 5694.743736531866, 5716.5140963017775, 5733.971330143323, 5740.942590574125, 5753.194552762617, 5421.105517589633, 5526.50784288248, 5529.502344788988, 5546.77812887488, 5595.118513965311, 5679.920815045129, 5682.346530149003, 5684.54523638108, 5709.115087161496, 5709.600327977002, 5292.391374991771, 5444.509994100392, 5458.7990642058685, 5487.533559647474, 5502.339719233718, 5417.702026388429, 5458.6724796512335, 5467.808626698046, 5471.699056551928, 5474.288342515607, 5701.942980570141, 5772.91983054909, 5773.307203135482, 5779.739911703899, 5783.334916484658, 3895.6493915547735, 3998.440218369489, 4012.398140278865, 4019.4774679291504, 4025.3961905714377, 5459.181122831607, 5483.533899618417, 5484.478974497416, 5499.450054994629, 5531.751071201725, 5383.353997520323, 5402.378726446509, 5495.203195536705, 5511.338639363302, 5513.641613295123, 5511.311086114236, 5514.972425137848, 5515.4760297771645, 5534.667919924817, 5554.555635549065, 5265.236540701653, 5382.196964017098, 5388.275751759399, 5451.64564303319, 5453.754581043783, 5507.642003269774, 5519.9448005521035, 5539.446055394428, 5544.63959842609, 5546.195801608825, 5357.92841431723, 5370.194470829407, 5380.650257733235, 5389.595780316414, 5398.325209348832], "value": 4209.22805609786, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.3198291580287, 767.8195624028352, 784.2432053068791, 842.6797816829604, 849.3417601358946, 15237.16195609241, 15958.601034974103, 15998.76001859973, 16004.359825606962, 16014.519564413056, 14754.852451475483, 14948.775768363455, 14956.102633841978, 14957.252137393114, 14963.251837408141, 455.1079883428484, 462.2880763624015, 603.9516838652897, 823.851706692795, 846.1411667157839, 842.5281842168374, 846.3060290561712, 848.6902280667542, 849.6941101203562, 849.9362547808909, 899.2850683706437, 899.8155378147496, 900.2437952120217, 900.5722281916103, 902.0348227396688, 893.9642414303453, 894.2756367342473, 894.6466145872377, 895.4537731983485, 895.7447127568677, 656.5076192855358, 656.6618191631313, 657.0144782825762, 658.2430205263937, 658.3548122839596, 14571.0, 14673.486427974969, 15246.39014439421, 15279.083255004623, 15281.235938203044, 14140.0, 14218.573442796733, 14340.35468403914, 14861.628459288497, 14968.775468367983, 10692.128877446416, 10752.247342686014, 10761.354318740823, 10827.404492752896, 11073.944630276877, 3759.285735710206, 3801.2777572261184, 3825.9617403826164, 3846.9615303847163, 3882.068303607114, 61867.690661546854, 63272.68363658198, 63625.3637463624, 64332.678336608486, 64700.0, 9936.50317484123, 10020.789814479418, 10223.59105635781, 10331.94834025825, 10367.429791361397, 20508.69236961447, 21046.579068418545, 21222.681659775117, 21497.247596334055, 21704.89147554252, 7418.369438597671, 7679.0, 7738.613069346623, 7834.451588388758, 8298.502089874626, 4158.08522125132, 4208.326667733148, 4262.893427664271, 4432.312991486325, 4443.888902777457, 3456.4815277708544, 3484.0, 3499.3876071687355, 3575.4815551745373, 3575.606683264839, 567.6508946997649, 572.1417873190214, 586.592318338759, 593.4807043836643, 601.8946684330225, 601.5518438763149, 625.4683519008806, 630.1839118341759, 637.91069250305, 658.4205898809017, 8601.182887625666, 8740.956295218482, 9366.67216647414, 9602.375845570015, 9790.706278811647, 646.6120327803375, 662.9303923088103, 663.326723375774, 693.774523279936, 721.3255606008399, 4350.564943505688, 4408.140412619572, 4544.250198717241, 4569.680122391467, 4584.564466375689, 49240.50759492431, 51092.0, 77001.0, 81695.59152204201, 82833.0, 70988.2901170992, 71979.0, 73236.0, 73282.26717732861, 73663.63168184125, 52660.73669631627, 64250.036249456294, 65319.34680653133, 65493.345066548725, 65600.6719966397, 8022.358211343195, 8198.467099638505, 8280.0, 8319.958400208203, 8389.286910612422, 33365.666343336256, 33750.49374259437, 41948.16103677848, 43515.78242108769, 43532.0, 41765.791171045166, 41946.0, 43871.78064109659, 57443.425565743804, 57693.0, 11918.940405298265, 11999.940000299943, 12047.939760301142, 12089.214201077253, 12358.691032724253, 12744.235345879277, 13089.280089594782, 13378.331083445983, 13450.0, 13484.595462136152, 12427.689307767378, 12640.55758048464, 12733.808992865299, 13421.66445838862, 13489.797653035015, 12421.75156496883, 12471.812922805984, 12500.0, 12662.176958497668, 12741.235525868478, 11356.488957996744, 11403.942980285046, 11607.76784464323, 11679.532818687498, 11794.174407791716, 9748.073932976356, 9945.850812237677, 10171.796564068825, 10258.948705256425, 10789.946050269698, 10017.449040302561, 10584.417857017937, 10623.0, 10693.09108725767, 10794.352338859693], "value": 6861.50121068153, "unit": "score"}], "name": "dromaeo_css", "value": 7132.204952955945, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 111.0, 109.0, 111.0, 111.0, 114.0, 112.0, 111.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 118.0, 117.0, 161.0, 124.0, 118.0, 123.0, 117.0, 143.0, 118.0], "value": 128.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 159.0, 161.0, 159.0, 161.0, 161.0, 159.0, 160.0, 159.0, 159.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 114.0, 76.0, 76.0, 75.0, 75.0, 95.0, 74.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 124.0, 82.0, 82.0, 82.0, 102.0, 82.0, 81.0, 118.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 118.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 145.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 51.0, 50.0, 53.0, 49.0, 50.0, 50.0, 49.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 61.0, 60.0, 59.0, 59.0, 60.0, 59.0, 60.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 74.0, 86.0, 77.0, 75.0, 79.0, 74.0, 81.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 127.0, 130.0, 128.0, 121.0, 121.0, 131.0, 122.0, 174.0, 122.0], "value": 130.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 159.0, 161.0, 161.0, 161.0, 160.0, 157.0, 159.0, 159.0, 162.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 64.0, 62.0, 62.0, 63.0, 61.0, 63.0, 62.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1459.3000000000002, "alertThreshold": 2.0}]} 14:25:27 INFO - Return code: 0 14:25:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:25:27 INFO - # TBPL SUCCESS # 14:25:27 INFO - Running post-action listener: _resource_record_post_action 14:25:27 INFO - [mozharness: 2017-02-15 22:25:27.822599Z] Finished run-tests step (success) 14:25:27 INFO - Running post-run listener: _resource_record_post_run 14:25:27 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 356352; Write bytes: 319823872; Read time: 272; Write time: 266820 14:25:27 INFO - TinderboxPrint: CPU usage
13.0% 14:25:27 INFO - TinderboxPrint: I/O read bytes / time
356,352 / 272 14:25:27 INFO - TinderboxPrint: I/O write bytes / time
319,823,872 / 266,820 14:25:27 INFO - TinderboxPrint: CPU idle
8,258.9 (87.0%) 14:25:27 INFO - TinderboxPrint: CPU user
1,187.5 (12.5%) 14:25:27 INFO - TinderboxPrint: Swap in / out
0 / 0 14:25:27 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101195776; Read time: 0; Write time: 123964 14:25:27 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 218161152; Read time: 0; Write time: 142796 14:25:28 INFO - Running post-run listener: _upload_blobber_files 14:25:28 INFO - Blob upload gear active. 14:25:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:25:28 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 14:25:28 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:25:28 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:25:28 INFO - (blobuploader) - INFO - Open directory for files ... 14:25:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:25:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:25:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:25:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:25:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:25:30 INFO - (blobuploader) - INFO - Done attempting. 14:25:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:25:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:25:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:25:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:25:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:25:34 INFO - (blobuploader) - INFO - Done attempting. 14:25:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:25:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:25:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:25:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:25:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:25:35 INFO - (blobuploader) - INFO - Done attempting. 14:25:35 INFO - (blobuploader) - INFO - Iteration through files over. 14:25:35 INFO - Return code: 0 14:25:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:25:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:25:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29f0ca9670c7b9e2854f1544aaead47b778adfb628cdcdc9a2579d2006b38b2d1702459b58494acd8df058a6ef83f4e0e3819d70bc5ad6a5ad44ca4c4a4b490b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ebafc31d8315a3330d0fac480e63abd8d7e5786b07bb5f44dd3c5ccf945e04da38170a7510fc979e27f5b8dabddf0a553b8e1d39ef93b05a3f0c1bd865fb7ebb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b47d450758e82f2dbe2206fd6d0f09af80c6c36dbc39334e4c5aef91b3049a7b15dd3a8976553f4d66ba16a08da7f54da92dad2e33f95341b3bac892d091db9c"} 14:25:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:25:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:25:35 INFO - Contents: 14:25:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29f0ca9670c7b9e2854f1544aaead47b778adfb628cdcdc9a2579d2006b38b2d1702459b58494acd8df058a6ef83f4e0e3819d70bc5ad6a5ad44ca4c4a4b490b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ebafc31d8315a3330d0fac480e63abd8d7e5786b07bb5f44dd3c5ccf945e04da38170a7510fc979e27f5b8dabddf0a553b8e1d39ef93b05a3f0c1bd865fb7ebb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b47d450758e82f2dbe2206fd6d0f09af80c6c36dbc39334e4c5aef91b3049a7b15dd3a8976553f4d66ba16a08da7f54da92dad2e33f95341b3bac892d091db9c"} 14:25:35 INFO - Running post-run listener: copy_logs_to_upload_dir 14:25:35 INFO - Copying logs to upload dir... 14:25:35 INFO - mkdir: /builds/slave/test/build/upload/logs 14:25:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.094727 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-02-15 14:25:35.045000) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 14:25:35.048785) ========= 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=1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756 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-Beta/sha512/29f0ca9670c7b9e2854f1544aaead47b778adfb628cdcdc9a2579d2006b38b2d1702459b58494acd8df058a6ef83f4e0e3819d70bc5ad6a5ad44ca4c4a4b490b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ebafc31d8315a3330d0fac480e63abd8d7e5786b07bb5f44dd3c5ccf945e04da38170a7510fc979e27f5b8dabddf0a553b8e1d39ef93b05a3f0c1bd865fb7ebb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b47d450758e82f2dbe2206fd6d0f09af80c6c36dbc39334e4c5aef91b3049a7b15dd3a8976553f4d66ba16a08da7f54da92dad2e33f95341b3bac892d091db9c"} build_url:https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/fIKCGboZRL61m6ppfvqgAA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29f0ca9670c7b9e2854f1544aaead47b778adfb628cdcdc9a2579d2006b38b2d1702459b58494acd8df058a6ef83f4e0e3819d70bc5ad6a5ad44ca4c4a4b490b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ebafc31d8315a3330d0fac480e63abd8d7e5786b07bb5f44dd3c5ccf945e04da38170a7510fc979e27f5b8dabddf0a553b8e1d39ef93b05a3f0c1bd865fb7ebb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b47d450758e82f2dbe2206fd6d0f09af80c6c36dbc39334e4c5aef91b3049a7b15dd3a8976553f4d66ba16a08da7f54da92dad2e33f95341b3bac892d091db9c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 14:25:35.076170) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 14:25:35.076682) ========= 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=1258088b6da462a47ba2cd90000001a2-1487196292.423238-387830756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 14:25:35.160965) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 14:25:35.161328) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 14:25:35.161639) ========= ========= Total master_lag: 0.16 =========