builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1483409881.32 results: success (0) buildid: 20170102163320 builduid: 7cede652e5da4b41a2386eae4490339f revision: 67635f34bbdcf21966af1c285724e8f5b1e64833 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-02 18:18:01.322503) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-02 18:18:01.322948) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-02 18:18:01.323247) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-02 18:18:01.369652) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 18:18:01.370181) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-02 18:18:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 113M=0s 2017-01-02 18:18:03 (113 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104420 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 18:18:01.488095) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 18:18:01.488408) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013791 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 18:18:01.539030) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 18:18:01.539384) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 67635f34bbdcf21966af1c285724e8f5b1e64833 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 67635f34bbdcf21966af1c285724e8f5b1e64833 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-02 18:18:03,207 truncating revision to first 12 chars 2017-01-02 18:18:03,207 Setting DEBUG logging. 2017-01-02 18:18:03,207 attempt 1/10 2017-01-02 18:18:03,207 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/67635f34bbdc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-02 18:18:03,518 unpacking tar archive at: mozilla-aurora-67635f34bbdc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.611612 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 18:18:02.165534) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-02 18:18:02.165856) ========= script_repo_revision: 67635f34bbdcf21966af1c285724e8f5b1e64833 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-02 18:18:02.166279) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-02 18:18:02.166816) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-02 18:18:02.176260) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-01-02 18:18:02.176521) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:18:03 INFO - MultiFileLogger online at 20170102 18:18:03 in /builds/slave/test 18:18:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:18:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:18:03 INFO - {'append_to_log': False, 18:18:03 INFO - 'base_work_dir': '/builds/slave/test', 18:18:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:18:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:18:03 INFO - 'branch': 'Mozilla-Aurora', 18:18:03 INFO - 'buildbot_json_path': 'buildprops.json', 18:18:03 INFO - 'config_files': ('talos/linux_config.py',), 18:18:03 INFO - 'default_actions': ('clobber', 18:18:03 INFO - 'read-buildbot-config', 18:18:03 INFO - 'download-and-extract', 18:18:03 INFO - 'populate-webroot', 18:18:03 INFO - 'create-virtualenv', 18:18:03 INFO - 'install', 18:18:03 INFO - 'run-tests'), 18:18:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:18:03 INFO - 'download_minidump_stackwalk': True, 18:18:03 INFO - 'download_symbols': 'ondemand', 18:18:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:18:03 INFO - 'tooltool.py': '/tools/tooltool.py', 18:18:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:18:03 INFO - '/tools/misc-python/virtualenv.py')}, 18:18:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:18:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:18:03 INFO - 'installer_path': 'installer.exe', 18:18:03 INFO - 'log_level': 'info', 18:18:03 INFO - 'log_name': 'talos', 18:18:03 INFO - 'log_to_console': True, 18:18:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:18:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:18:03 INFO - 'opt_config_files': (), 18:18:03 INFO - 'pip_index': False, 18:18:03 INFO - 'sps_profile': False, 18:18:03 INFO - 'sps_profile_interval': 0, 18:18:03 INFO - 'suite': 'dromaeojs', 18:18:03 INFO - 'system_bits': '32', 18:18:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:18:03 INFO - 'title': 'talos-linux64-ix-017', 18:18:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:18:03 INFO - 'use_talos_json': True, 18:18:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:18:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:18:03 INFO - 'work_dir': 'build'} 18:18:03 INFO - [mozharness: 2017-01-03 02:18:03.936223Z] Running clobber step. 18:18:03 INFO - Running pre-action listener: _resource_record_pre_action 18:18:03 INFO - Running main action method: clobber 18:18:03 INFO - rmtree: /builds/slave/test/build 18:18:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:18:04 INFO - Running post-action listener: _resource_record_post_action 18:18:04 INFO - [mozharness: 2017-01-03 02:18:04.397266Z] Finished clobber step (success) 18:18:04 INFO - [mozharness: 2017-01-03 02:18:04.397368Z] Running read-buildbot-config step. 18:18:04 INFO - Running pre-action listener: _resource_record_pre_action 18:18:04 INFO - Running main action method: read_buildbot_config 18:18:04 INFO - Using buildbot properties: 18:18:04 INFO - { 18:18:04 INFO - "project": "", 18:18:04 INFO - "product": "firefox", 18:18:04 INFO - "script_repo_revision": "production", 18:18:04 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 18:18:04 INFO - "repository": "", 18:18:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 18:18:04 INFO - "buildid": "20170102163320", 18:18:04 INFO - "pgo_build": "True", 18:18:04 INFO - "basedir": "/builds/slave/test", 18:18:04 INFO - "buildnumber": 704, 18:18:04 INFO - "slavename": "talos-linux64-ix-017", 18:18:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:18:04 INFO - "platform": "ubuntu64_hw", 18:18:04 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 18:18:04 INFO - "branch": "mozilla-aurora", 18:18:04 INFO - "repo_path": "releases/mozilla-aurora", 18:18:04 INFO - "revision": "67635f34bbdcf21966af1c285724e8f5b1e64833", 18:18:04 INFO - "stage_platform": "linux64-pgo", 18:18:04 INFO - "builduid": "7cede652e5da4b41a2386eae4490339f", 18:18:04 INFO - "slavebuilddir": "test" 18:18:04 INFO - } 18:18:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 18:18:04 INFO - Running post-action listener: _resource_record_post_action 18:18:04 INFO - [mozharness: 2017-01-03 02:18:04.399772Z] Finished read-buildbot-config step (success) 18:18:04 INFO - [mozharness: 2017-01-03 02:18:04.399860Z] Running download-and-extract step. 18:18:04 INFO - Running pre-action listener: _resource_record_pre_action 18:18:04 INFO - Running main action method: download_and_extract 18:18:04 INFO - mkdir: /builds/slave/test/build/tests 18:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:04 INFO - trying https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 18:18:04 INFO - Downloading https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 18:18:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:18:04 INFO - Downloaded 1361 bytes. 18:18:04 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 18:18:04 INFO - Using the following test package requirements: 18:18:04 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 18:18:04 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 18:18:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 18:18:04 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 18:18:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 18:18:04 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 18:18:04 INFO - u'jsshell-linux-x86_64.zip'], 18:18:04 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 18:18:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 18:18:04 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 18:18:04 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 18:18:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 18:18:04 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 18:18:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 18:18:04 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 18:18:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 18:18:04 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 18:18:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 18:18:04 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:18:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 18:18:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:18:04 INFO - Fetch https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 18:18:05 INFO - Http code: 200 18:18:05 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 18:18:05 INFO - x-amz-cf-id: jCHPtCayWszkcTYuudtT_JR3rcYD_0B9h5GmA6uS5Wa3Y7WqsbjnAA== 18:18:05 INFO - x-amz-version-id: Bh17rMyzTnJo0n9XUyz.C1cSNi7Pt4mK 18:18:05 INFO - Expected file size: 21940674 18:18:05 INFO - Obtained file size: 21940674 18:18:09 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:18:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 18:18:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:18:09 INFO - Fetch https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 18:18:10 INFO - Http code: 200 18:18:10 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 18:18:10 INFO - x-amz-cf-id: snrbS4azoiQYuRuReUKsnpJx_YZH-7q_23BGtB0IyIMAGsdQxun0Mg== 18:18:10 INFO - x-amz-version-id: Bh17rMyzTnJo0n9XUyz.C1cSNi7Pt4mK 18:18:10 INFO - Expected file size: 21940674 18:18:10 INFO - Obtained file size: 21940674 18:18:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 18:18:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:18:15 INFO - Fetch https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 18:18:15 INFO - Http code: 200 18:18:15 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 18:18:15 INFO - x-amz-cf-id: aXcM_yD15PonMW2biLJYaR7C_aSez1kkzBAYw5Brom651R_nrkCXHg== 18:18:15 INFO - x-amz-version-id: M7jOTGQaKib3J0fFMYP4qVXkr1bmertK 18:18:15 INFO - Expected file size: 14409038 18:18:15 INFO - Obtained file size: 14409038 18:18:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:16 INFO - trying https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 18:18:16 INFO - Downloading https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 18:18:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:18:17 INFO - Downloaded 64032620 bytes. 18:18:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 18:18:17 INFO - mkdir: /builds/slave/test/properties 18:18:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:18:17 INFO - Writing to file /builds/slave/test/properties/build_url 18:18:17 INFO - Contents: 18:18:17 INFO - build_url:https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 18:18:17 INFO - Running post-action listener: _resource_record_post_action 18:18:17 INFO - Running post-action listener: set_extra_try_arguments 18:18:17 INFO - [mozharness: 2017-01-03 02:18:17.880903Z] Finished download-and-extract step (success) 18:18:17 INFO - [mozharness: 2017-01-03 02:18:17.881130Z] Running populate-webroot step. 18:18:17 INFO - Running pre-action listener: _resource_record_pre_action 18:18:17 INFO - Running main action method: populate_webroot 18:18:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:18:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:18:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:18:17 INFO - '--tppagecycles', 18:18:17 INFO - '7'], 18:18:17 INFO - 'tests': ['tsvgm']}}, 18:18:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:18:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:18:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:18:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:18:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:18:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:18:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:17 INFO - 'talos_options': ['--disable-e10s'], 18:18:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:17 INFO - 'talos_options': ['--disable-e10s'], 18:18:17 INFO - 'tests': ['damp', 'tps']}, 18:18:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:17 INFO - 'tests': ['damp', 'tps']}, 18:18:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:18:17 INFO - 'tests': ['dromaeo_dom']}, 18:18:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:18:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:18:17 INFO - 'tests': ['basic_compositor_video']}, 18:18:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:18:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:18:17 INFO - 'tests': ['a11yr', 18:18:17 INFO - 'ts_paint', 18:18:17 INFO - 'tpaint', 18:18:17 INFO - 'sessionrestore', 18:18:17 INFO - 'sessionrestore_no_auto_restore', 18:18:17 INFO - 'tabpaint']}, 18:18:17 INFO - 'other-e10s': {'tests': ['a11yr', 18:18:17 INFO - 'ts_paint', 18:18:17 INFO - 'tpaint', 18:18:17 INFO - 'sessionrestore', 18:18:17 INFO - 'sessionrestore_no_auto_restore', 18:18:17 INFO - 'tabpaint']}, 18:18:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:18:17 INFO - 'ts_paint', 18:18:17 INFO - 'tpaint', 18:18:17 INFO - 'sessionrestore', 18:18:17 INFO - 'sessionrestore_no_auto_restore', 18:18:17 INFO - 'tabpaint']}, 18:18:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:18:17 INFO - 'ts_paint', 18:18:17 INFO - 'tpaint', 18:18:17 INFO - 'sessionrestore', 18:18:17 INFO - 'sessionrestore_no_auto_restore', 18:18:17 INFO - 'tabpaint']}, 18:18:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:18:17 INFO - 'tests': ['a11yr', 18:18:17 INFO - 'ts_paint', 18:18:17 INFO - 'tpaint', 18:18:17 INFO - 'sessionrestore', 18:18:17 INFO - 'sessionrestore_no_auto_restore', 18:18:17 INFO - 'tabpaint']}, 18:18:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:18:17 INFO - 'tests': ['a11yr', 18:18:17 INFO - 'ts_paint', 18:18:17 INFO - 'tpaint', 18:18:17 INFO - 'sessionrestore', 18:18:17 INFO - 'sessionrestore_no_auto_restore', 18:18:17 INFO - 'tabpaint']}, 18:18:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:18:17 INFO - 'tests': ['tsvgx', 18:18:17 INFO - 'tsvgr_opacity', 18:18:17 INFO - 'tart', 18:18:17 INFO - 'tscrollx', 18:18:17 INFO - 'cart']}, 18:18:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:18:17 INFO - 'tsvgr_opacity', 18:18:17 INFO - 'tart', 18:18:17 INFO - 'tscrollx', 18:18:17 INFO - 'cart']}, 18:18:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:17 INFO - 'talos_options': ['--disable-e10s'], 18:18:17 INFO - 'tests': ['tp5o']}, 18:18:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:17 INFO - 'tests': ['tp5o']}, 18:18:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:17 INFO - 'talos_options': ['--disable-e10s', 18:18:17 INFO - '--xperf_path', 18:18:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:17 INFO - 'tests': ['tp5n']}, 18:18:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:17 INFO - 'talos_options': ['--xperf_path', 18:18:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:17 INFO - 'tests': ['tp5n']}}, 18:18:17 INFO - 'talos.zip': {'path': '', 18:18:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:18:17 INFO - Running post-action listener: _resource_record_post_action 18:18:17 INFO - [mozharness: 2017-01-03 02:18:17.899588Z] Finished populate-webroot step (success) 18:18:17 INFO - [mozharness: 2017-01-03 02:18:17.899675Z] Running create-virtualenv step. 18:18:17 INFO - Running pre-action listener: _resource_record_pre_action 18:18:17 INFO - Running main action method: create_virtualenv 18:18:17 INFO - Creating virtualenv /builds/slave/test/build/venv 18:18:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:18:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:18:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:18:18 INFO - Using real prefix '/usr' 18:18:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:18:18 INFO - Installing distribute.............................................................................................................................................................................................done. 18:18:20 INFO - Installing pip.................done. 18:18:20 INFO - Return code: 0 18:18:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:18:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:18:20 INFO - Reading from file tmpfile_stdout 18:18:20 INFO - Output received: 18:18:20 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:18:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f700c831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2977f60>, '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 0x2978d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29791d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602', '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 18:18:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:18:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:18:20 INFO - Using env: {'DISPLAY': ':0', 18:18:20 INFO - 'HOME': '/home/cltbld', 18:18:20 INFO - 'LANG': 'en_US.UTF-8', 18:18:20 INFO - 'LANGUAGE': 'en_US:en', 18:18:20 INFO - 'LOGNAME': 'cltbld', 18:18:20 INFO - 'MAIL': '/var/mail/cltbld', 18:18:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:20 INFO - 'MOZ_NO_REMOTE': '1', 18:18:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:20 INFO - 'NO_EM_RESTART': '1', 18:18:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:20 INFO - 'PWD': '/builds/slave/test', 18:18:20 INFO - 'SHELL': '/bin/bash', 18:18:20 INFO - 'SHLVL': '1', 18:18:20 INFO - 'TERM': 'linux', 18:18:20 INFO - 'TMOUT': '86400', 18:18:20 INFO - 'USER': 'cltbld', 18:18:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602', 18:18:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:20 INFO - '_': '/tools/buildbot/bin/python'} 18:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:20 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 18:18:20 INFO - Cleaning up... 18:18:20 INFO - Return code: 0 18:18:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f700c831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2977f60>, '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 0x2978d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29791d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602', '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 18:18:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:18:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:18:20 INFO - Using env: {'DISPLAY': ':0', 18:18:20 INFO - 'HOME': '/home/cltbld', 18:18:20 INFO - 'LANG': 'en_US.UTF-8', 18:18:20 INFO - 'LANGUAGE': 'en_US:en', 18:18:20 INFO - 'LOGNAME': 'cltbld', 18:18:20 INFO - 'MAIL': '/var/mail/cltbld', 18:18:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:20 INFO - 'MOZ_NO_REMOTE': '1', 18:18:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:20 INFO - 'NO_EM_RESTART': '1', 18:18:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:20 INFO - 'PWD': '/builds/slave/test', 18:18:20 INFO - 'SHELL': '/bin/bash', 18:18:20 INFO - 'SHLVL': '1', 18:18:20 INFO - 'TERM': 'linux', 18:18:20 INFO - 'TMOUT': '86400', 18:18:20 INFO - 'USER': 'cltbld', 18:18:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602', 18:18:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:20 INFO - '_': '/tools/buildbot/bin/python'} 18:18:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:21 INFO - Downloading/unpacking psutil>=3.1.1 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:18:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:23 INFO - Installing collected packages: psutil 18:18:23 INFO - Running setup.py install for psutil 18:18:23 INFO - building 'psutil._psutil_linux' extension 18:18:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:18:23 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 18:18:23 INFO - building 'psutil._psutil_posix' extension 18:18:23 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 18:18:23 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 18:18:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:23 INFO - Successfully installed psutil 18:18:23 INFO - Cleaning up... 18:18:23 INFO - Return code: 0 18:18:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:18: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')]} 18:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18: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')]} 18:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f700c831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2977f60>, '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 0x2978d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29791d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602', '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 18:18: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:18: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 mozsystemmonitor==0.3 18:18:23 INFO - Using env: {'DISPLAY': ':0', 18:18:23 INFO - 'HOME': '/home/cltbld', 18:18:23 INFO - 'LANG': 'en_US.UTF-8', 18:18:23 INFO - 'LANGUAGE': 'en_US:en', 18:18:23 INFO - 'LOGNAME': 'cltbld', 18:18:23 INFO - 'MAIL': '/var/mail/cltbld', 18:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:23 INFO - 'MOZ_NO_REMOTE': '1', 18:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:23 INFO - 'NO_EM_RESTART': '1', 18:18:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:23 INFO - 'PWD': '/builds/slave/test', 18:18:23 INFO - 'SHELL': '/bin/bash', 18:18:23 INFO - 'SHLVL': '1', 18:18:23 INFO - 'TERM': 'linux', 18:18:23 INFO - 'TMOUT': '86400', 18:18:23 INFO - 'USER': 'cltbld', 18:18:23 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602', 18:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:23 INFO - '_': '/tools/buildbot/bin/python'} 18:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:18:24 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 18:18:24 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 18:18:24 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 18:18:24 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 18:18:24 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 18:18:24 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 18:18:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:18:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:18:26 INFO - Installing collected packages: mozsystemmonitor 18:18:26 INFO - Running setup.py install for mozsystemmonitor 18:18:26 INFO - Successfully installed mozsystemmonitor 18:18:26 INFO - Cleaning up... 18:18:26 INFO - Return code: 0 18:18:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:18: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')]} 18:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18: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')]} 18:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f700c831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2977f60>, '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 0x2978d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29791d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602', '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 18:18:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:18:26 INFO - Using env: {'DISPLAY': ':0', 18:18:26 INFO - 'HOME': '/home/cltbld', 18:18:26 INFO - 'LANG': 'en_US.UTF-8', 18:18:26 INFO - 'LANGUAGE': 'en_US:en', 18:18:26 INFO - 'LOGNAME': 'cltbld', 18:18:26 INFO - 'MAIL': '/var/mail/cltbld', 18:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:26 INFO - 'MOZ_NO_REMOTE': '1', 18:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:26 INFO - 'NO_EM_RESTART': '1', 18:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:26 INFO - 'PWD': '/builds/slave/test', 18:18:26 INFO - 'SHELL': '/bin/bash', 18:18:26 INFO - 'SHLVL': '1', 18:18:26 INFO - 'TERM': 'linux', 18:18:26 INFO - 'TMOUT': '86400', 18:18:26 INFO - 'USER': 'cltbld', 18:18:26 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602', 18:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:26 INFO - '_': '/tools/buildbot/bin/python'} 18:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:26 INFO - Downloading/unpacking jsonschema==2.5.1 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:18:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18:28 INFO - Downloading functools32-3.2.3-2.tar.gz 18:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:18:28 INFO - warning: no files found matching '*.txt' 18:18:28 INFO - no previously-included directories found matching 'build' 18:18:28 INFO - no previously-included directories found matching 'dist' 18:18:28 INFO - no previously-included directories found matching '.git*' 18:18:28 INFO - Installing collected packages: jsonschema, functools32 18:18:28 INFO - Running setup.py install for functools32 18:18:28 INFO - warning: no files found matching '*.txt' 18:18:28 INFO - no previously-included directories found matching 'build' 18:18:28 INFO - no previously-included directories found matching 'dist' 18:18:28 INFO - no previously-included directories found matching '.git*' 18:18:28 INFO - Successfully installed jsonschema functools32 18:18:28 INFO - Cleaning up... 18:18:28 INFO - Return code: 0 18:18:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:18:28 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')]} 18:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:28 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')]} 18:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:28 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 0x7f700c831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2977f60>, '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 0x2978d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29791d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602', '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 18:18:28 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 18:18:28 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 18:18:28 INFO - Using env: {'DISPLAY': ':0', 18:18:28 INFO - 'HOME': '/home/cltbld', 18:18:28 INFO - 'LANG': 'en_US.UTF-8', 18:18:28 INFO - 'LANGUAGE': 'en_US:en', 18:18:28 INFO - 'LOGNAME': 'cltbld', 18:18:28 INFO - 'MAIL': '/var/mail/cltbld', 18:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:28 INFO - 'MOZ_NO_REMOTE': '1', 18:18:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:28 INFO - 'NO_EM_RESTART': '1', 18:18:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:28 INFO - 'PWD': '/builds/slave/test', 18:18:28 INFO - 'SHELL': '/bin/bash', 18:18:28 INFO - 'SHLVL': '1', 18:18:28 INFO - 'TERM': 'linux', 18:18:28 INFO - 'TMOUT': '86400', 18:18:28 INFO - 'USER': 'cltbld', 18:18:28 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602', 18:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:28 INFO - '_': '/tools/buildbot/bin/python'} 18:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:18:29 INFO - Cleaning up... 18:18:29 INFO - Return code: 0 18:18:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f700c831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2977f60>, '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 0x2978d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29791d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602', '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 18:18:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:18:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:18:29 INFO - Using env: {'DISPLAY': ':0', 18:18:29 INFO - 'HOME': '/home/cltbld', 18:18:29 INFO - 'LANG': 'en_US.UTF-8', 18:18:29 INFO - 'LANGUAGE': 'en_US:en', 18:18:29 INFO - 'LOGNAME': 'cltbld', 18:18:29 INFO - 'MAIL': '/var/mail/cltbld', 18:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:29 INFO - 'MOZ_NO_REMOTE': '1', 18:18:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:29 INFO - 'NO_EM_RESTART': '1', 18:18:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:29 INFO - 'PWD': '/builds/slave/test', 18:18:29 INFO - 'SHELL': '/bin/bash', 18:18:29 INFO - 'SHLVL': '1', 18:18:29 INFO - 'TERM': 'linux', 18:18:29 INFO - 'TMOUT': '86400', 18:18:29 INFO - 'USER': 'cltbld', 18:18:29 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602', 18:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:29 INFO - '_': '/tools/buildbot/bin/python'} 18:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:29 INFO - Downloading/unpacking blobuploader==1.2.4 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18:31 INFO - Downloading blobuploader-1.2.4.tar.gz 18:18:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:18:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:18:31 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 18:18:31 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 18:18:31 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 18:18:31 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 18:18:31 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 18:18:31 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 18:18:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:18:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:18:31 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 18:18:31 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 18:18:31 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 18:18:31 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 18:18:31 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 18:18:31 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 18:18:32 INFO - Downloading docopt-0.6.1.tar.gz 18:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:18:32 INFO - Installing collected packages: blobuploader, requests, docopt 18:18:32 INFO - Running setup.py install for blobuploader 18:18:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:18:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:18:32 INFO - Running setup.py install for requests 18:18:32 INFO - Running setup.py install for docopt 18:18:32 INFO - Successfully installed blobuploader requests docopt 18:18:32 INFO - Cleaning up... 18:18:32 INFO - Return code: 0 18:18:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:32 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')]} 18:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:32 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')]} 18:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:32 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 0x7f700c831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2977f60>, '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 0x2978d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29791d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602', '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 18:18:32 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 18:18:32 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 18:18:32 INFO - Using env: {'DISPLAY': ':0', 18:18:32 INFO - 'HOME': '/home/cltbld', 18:18:32 INFO - 'LANG': 'en_US.UTF-8', 18:18:32 INFO - 'LANGUAGE': 'en_US:en', 18:18:32 INFO - 'LOGNAME': 'cltbld', 18:18:32 INFO - 'MAIL': '/var/mail/cltbld', 18:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:32 INFO - 'MOZ_NO_REMOTE': '1', 18:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:32 INFO - 'NO_EM_RESTART': '1', 18:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:32 INFO - 'PWD': '/builds/slave/test', 18:18:32 INFO - 'SHELL': '/bin/bash', 18:18:32 INFO - 'SHLVL': '1', 18:18:32 INFO - 'TERM': 'linux', 18:18:32 INFO - 'TMOUT': '86400', 18:18:32 INFO - 'USER': 'cltbld', 18:18:32 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602', 18:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:32 INFO - '_': '/tools/buildbot/bin/python'} 18:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:18:33 INFO - Running setup.py (path:/tmp/pip-2Z9N5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:18:33 INFO - Running setup.py (path:/tmp/pip-Rg2A64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:18:33 INFO - Running setup.py (path:/tmp/pip-l0x0Qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:18:33 INFO - Running setup.py (path:/tmp/pip-TQsEcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:18:33 INFO - Running setup.py (path:/tmp/pip-gWSjrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:18:33 INFO - Running setup.py (path:/tmp/pip-qroN5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:18:33 INFO - Running setup.py (path:/tmp/pip-jEDeoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:18:33 INFO - Running setup.py (path:/tmp/pip-72wnW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:18:33 INFO - Running setup.py (path:/tmp/pip-oskVnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:18:33 INFO - Running setup.py (path:/tmp/pip-HOOw6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:18:33 INFO - Running setup.py (path:/tmp/pip-QrRxZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:18:33 INFO - Running setup.py (path:/tmp/pip-aRgEYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:18:33 INFO - Running setup.py (path:/tmp/pip-IKbAjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:18:33 INFO - Running setup.py (path:/tmp/pip-zGYHPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:34 INFO - Running setup.py (path:/tmp/pip-8TTfWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:18:34 INFO - Running setup.py (path:/tmp/pip-Dasfmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:18:34 INFO - Running setup.py (path:/tmp/pip-OGCmOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:18:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:18:34 INFO - Running setup.py install for manifestparser 18:18:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:18:34 INFO - Running setup.py install for mozcrash 18:18:34 INFO - Running setup.py install for mozdebug 18:18:34 INFO - Running setup.py install for mozdevice 18:18:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:18:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:18:34 INFO - Running setup.py install for mozfile 18:18:34 INFO - Running setup.py install for mozhttpd 18:18:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:18:34 INFO - Running setup.py install for mozinfo 18:18:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:18:34 INFO - Running setup.py install for mozInstall 18:18:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:18:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:18:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:18:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:18:35 INFO - Running setup.py install for mozleak 18:18:35 INFO - Running setup.py install for mozlog 18:18:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:18:35 INFO - Running setup.py install for moznetwork 18:18:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:18:35 INFO - Running setup.py install for mozprocess 18:18:35 INFO - Running setup.py install for mozprofile 18:18:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:18:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:18:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:18:35 INFO - Running setup.py install for mozrunner 18:18:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:18:35 INFO - Running setup.py install for mozscreenshot 18:18:35 INFO - Running setup.py install for moztest 18:18:35 INFO - Running setup.py install for mozversion 18:18:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:18:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:18:36 INFO - Cleaning up... 18:18:36 INFO - Return code: 0 18:18:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:36 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 0x7f700c831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2977f60>, '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 0x2978d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29791d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602', '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 18:18:36 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 18:18:36 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 18:18:36 INFO - Using env: {'DISPLAY': ':0', 18:18:36 INFO - 'HOME': '/home/cltbld', 18:18:36 INFO - 'LANG': 'en_US.UTF-8', 18:18:36 INFO - 'LANGUAGE': 'en_US:en', 18:18:36 INFO - 'LOGNAME': 'cltbld', 18:18:36 INFO - 'MAIL': '/var/mail/cltbld', 18:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:36 INFO - 'MOZ_NO_REMOTE': '1', 18:18:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:36 INFO - 'NO_EM_RESTART': '1', 18:18:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:36 INFO - 'PWD': '/builds/slave/test', 18:18:36 INFO - 'SHELL': '/bin/bash', 18:18:36 INFO - 'SHLVL': '1', 18:18:36 INFO - 'TERM': 'linux', 18:18:36 INFO - 'TMOUT': '86400', 18:18:36 INFO - 'USER': 'cltbld', 18:18:36 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602', 18:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:36 INFO - '_': '/tools/buildbot/bin/python'} 18:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:18:36 INFO - Running setup.py (path:/tmp/pip-OFsbF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:18:36 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)) 18:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:18:36 INFO - Running setup.py (path:/tmp/pip-2N4BnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:18:36 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)) 18:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:18:36 INFO - Running setup.py (path:/tmp/pip-uLOwj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:18:36 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)) 18:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:18:36 INFO - Running setup.py (path:/tmp/pip-UViOgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:18:36 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)) 18:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:18:36 INFO - Running setup.py (path:/tmp/pip-AR9ylb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:18:36 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)) 18:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:18:36 INFO - Running setup.py (path:/tmp/pip-E2uGdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:18:36 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)) 18:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:18:36 INFO - Running setup.py (path:/tmp/pip-8724aX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:18:36 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)) 18:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:18:36 INFO - Running setup.py (path:/tmp/pip-kzNHuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:18:36 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)) 18:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:18:36 INFO - Running setup.py (path:/tmp/pip-bCaCbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:18:36 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)) 18:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:18:36 INFO - Running setup.py (path:/tmp/pip-zv5zEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:18:37 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)) 18:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:18:37 INFO - Running setup.py (path:/tmp/pip-ZrWyQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:18:37 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)) 18:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:18:37 INFO - Running setup.py (path:/tmp/pip-DFsJbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:18:37 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)) 18:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:18:37 INFO - Running setup.py (path:/tmp/pip-6suCh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:18:37 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)) 18:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:18:37 INFO - Running setup.py (path:/tmp/pip-a4XPOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:18:37 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)) 18:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:37 INFO - Running setup.py (path:/tmp/pip-DNoHC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:37 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)) 18:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:18:37 INFO - Running setup.py (path:/tmp/pip-vwMrp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:18:37 INFO - Running setup.py (path:/tmp/pip-wtCmMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:18:37 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)) 18:18:37 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)) 18:18:37 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)) 18:18:37 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)) 18:18:37 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)) 18:18:37 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)) 18:18:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:18:37 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 18:18:37 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 18:18:37 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 18:18:37 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 18:18:37 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 18:18:37 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 18:18:39 INFO - Downloading blessings-1.6.tar.gz 18:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:18:39 INFO - Installing collected packages: blessings 18:18:39 INFO - Running setup.py install for blessings 18:18:39 INFO - Successfully installed blessings 18:18:39 INFO - Cleaning up... 18:18:39 INFO - Return code: 0 18:18:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:18:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:18:39 INFO - Reading from file tmpfile_stdout 18:18:39 INFO - Current package versions: 18:18:39 INFO - argparse == 1.2.1 18:18:39 INFO - blessings == 1.6 18:18:39 INFO - blobuploader == 1.2.4 18:18:39 INFO - docopt == 0.6.1 18:18:39 INFO - functools32 == 3.2.3-2 18:18:39 INFO - jsonschema == 2.5.1 18:18:39 INFO - manifestparser == 1.1 18:18:39 INFO - mozInstall == 1.12 18:18:39 INFO - mozcrash == 1.0 18:18:39 INFO - mozdebug == 0.1 18:18:39 INFO - mozdevice == 0.48 18:18:39 INFO - mozfile == 1.2 18:18:39 INFO - mozhttpd == 0.7 18:18:39 INFO - mozinfo == 0.9 18:18:39 INFO - mozleak == 0.1 18:18:39 INFO - mozlog == 3.4 18:18:39 INFO - moznetwork == 0.27 18:18:39 INFO - mozprocess == 0.23 18:18:39 INFO - mozprofile == 0.28 18:18:39 INFO - mozrunner == 6.13 18:18:39 INFO - mozscreenshot == 0.1 18:18:39 INFO - mozsystemmonitor == 0.3 18:18:39 INFO - moztest == 0.7 18:18:39 INFO - mozversion == 1.4 18:18:39 INFO - psutil == 3.1.1 18:18:39 INFO - requests == 1.2.3 18:18:39 INFO - wsgiref == 0.1.2 18:18:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:39 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')]} 18:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:39 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')]} 18:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:39 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 0x7f700c831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2977f60>, '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 0x2978d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29791d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602', '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 18:18:39 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 18:18:40 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 18:18:40 INFO - Using env: {'DISPLAY': ':0', 18:18:40 INFO - 'HOME': '/home/cltbld', 18:18:40 INFO - 'LANG': 'en_US.UTF-8', 18:18:40 INFO - 'LANGUAGE': 'en_US:en', 18:18:40 INFO - 'LOGNAME': 'cltbld', 18:18:40 INFO - 'MAIL': '/var/mail/cltbld', 18:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:40 INFO - 'MOZ_NO_REMOTE': '1', 18:18:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:40 INFO - 'NO_EM_RESTART': '1', 18:18:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:40 INFO - 'PWD': '/builds/slave/test', 18:18:40 INFO - 'SHELL': '/bin/bash', 18:18:40 INFO - 'SHLVL': '1', 18:18:40 INFO - 'TERM': 'linux', 18:18:40 INFO - 'TMOUT': '86400', 18:18:40 INFO - 'USER': 'cltbld', 18:18:40 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602', 18:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:40 INFO - '_': '/tools/buildbot/bin/python'} 18:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:40 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)) 18:18:40 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)) 18:18:40 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)) 18:18:40 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)) 18:18:40 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)) 18:18:40 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)) 18:18:40 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)) 18:18:40 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)) 18:18:40 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)) 18:18:40 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)) 18:18:40 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)) 18:18:40 INFO - Cleaning up... 18:18:40 INFO - Return code: 0 18:18:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:18:40 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')]} 18:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:40 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')]} 18:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:40 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 0x7f700c831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2977f60>, '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 0x2978d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29791d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602', '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 18:18:40 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 18:18:40 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 18:18:40 INFO - Using env: {'DISPLAY': ':0', 18:18:40 INFO - 'HOME': '/home/cltbld', 18:18:40 INFO - 'LANG': 'en_US.UTF-8', 18:18:40 INFO - 'LANGUAGE': 'en_US:en', 18:18:40 INFO - 'LOGNAME': 'cltbld', 18:18:40 INFO - 'MAIL': '/var/mail/cltbld', 18:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:40 INFO - 'MOZ_NO_REMOTE': '1', 18:18:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:40 INFO - 'NO_EM_RESTART': '1', 18:18:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:40 INFO - 'PWD': '/builds/slave/test', 18:18:40 INFO - 'SHELL': '/bin/bash', 18:18:40 INFO - 'SHLVL': '1', 18:18:40 INFO - 'TERM': 'linux', 18:18:40 INFO - 'TMOUT': '86400', 18:18:40 INFO - 'USER': 'cltbld', 18:18:40 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602', 18:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:40 INFO - '_': '/tools/buildbot/bin/python'} 18:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:18:40 INFO - Cleaning up... 18:18:40 INFO - Return code: 0 18:18:40 INFO - Running post-action listener: _resource_record_post_action 18:18:40 INFO - Running post-action listener: _start_resource_monitoring 18:18:40 INFO - Starting resource monitoring. 18:18:40 INFO - [mozharness: 2017-01-03 02:18:40.502000Z] Finished create-virtualenv step (success) 18:18:40 INFO - [mozharness: 2017-01-03 02:18:40.502457Z] Running install step. 18:18:40 INFO - Running pre-action listener: _resource_record_pre_action 18:18:40 INFO - Running main action method: install 18:18:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:18:40 INFO - Reading from file tmpfile_stdout 18:18:40 INFO - Detecting whether we're running mozinstall >=1.0... 18:18:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:18:40 INFO - Reading from file tmpfile_stdout 18:18:40 INFO - Output received: 18:18:40 INFO - Usage: mozinstall [options] installer 18:18:40 INFO - Options: 18:18:40 INFO - -h, --help show this help message and exit 18:18:40 INFO - -d DEST, --destination=DEST 18:18:40 INFO - Directory to install application into. [default: 18:18:40 INFO - "/builds/slave/test"] 18:18:40 INFO - --app=APP Application being installed. [default: firefox] 18:18:40 INFO - mkdir: /builds/slave/test/build/application 18:18:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:18:56 INFO - Reading from file tmpfile_stdout 18:18:56 INFO - Output received: 18:18:56 INFO - /builds/slave/test/build/application/firefox/firefox 18:18:56 INFO - Running post-action listener: _resource_record_post_action 18:18:56 INFO - [mozharness: 2017-01-03 02:18:56.728403Z] Finished install step (success) 18:18:56 INFO - [mozharness: 2017-01-03 02:18:56.728646Z] Running run-tests step. 18:18:56 INFO - Running pre-action listener: _resource_record_pre_action 18:18:56 INFO - Running main action method: run_tests 18:18:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:18:56 INFO - Python 2.7.3 18:18:56 INFO - Return code: 0 18:18:56 INFO - grabbing minidump binary from tooltool 18:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:56 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 0x2977f60>, '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 0x2978d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29791d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:18:56 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 18:18:56 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 18:18:56 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 18:18:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:18:56 INFO - Return code: 0 18:18:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:18:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:18:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:18:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:18:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:18:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:18:56 INFO - Using env: {'DISPLAY': ':0', 18:18:56 INFO - 'HOME': '/home/cltbld', 18:18:56 INFO - 'LANG': 'en_US.UTF-8', 18:18:56 INFO - 'LANGUAGE': 'en_US:en', 18:18:56 INFO - 'LOGNAME': 'cltbld', 18:18:56 INFO - 'MAIL': '/var/mail/cltbld', 18:18:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:18:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:56 INFO - 'MOZ_NO_REMOTE': '1', 18:18:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:56 INFO - 'NO_EM_RESTART': '1', 18:18:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:56 INFO - 'PWD': '/builds/slave/test', 18:18:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:18:56 INFO - 'SHELL': '/bin/bash', 18:18:56 INFO - 'SHLVL': '1', 18:18:56 INFO - 'TERM': 'linux', 18:18:56 INFO - 'TMOUT': '86400', 18:18:56 INFO - 'USER': 'cltbld', 18:18:56 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602', 18:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:56 INFO - '_': '/tools/buildbot/bin/python'} 18:18:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:18:57 INFO - mozversion application_buildid: 20170102163320 18:18:57 INFO - mozversion application_changeset: 67635f34bbdcf21966af1c285724e8f5b1e64833 18:18:57 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:18:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:18:57 INFO - mozversion application_name: Firefox 18:18:57 INFO - mozversion application_remotingname: firefox-dev 18:18:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:18:57 INFO - mozversion application_vendor: Mozilla 18:18:57 INFO - mozversion application_version: 52.0a2 18:18:57 INFO - mozversion platform_buildid: 20170102163320 18:18:57 INFO - mozversion platform_changeset: 67635f34bbdcf21966af1c285724e8f5b1e64833 18:18:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:18:57 INFO - mozversion platform_version: 52.0a2 18:18:57 INFO - using testdate: 1483409937 18:18:57 INFO - actual date: 1483409937 18:18:57 INFO - starting webserver on 'localhost:34971' 18:18:57 INFO - SUITE-START | Running 2 tests 18:18:57 INFO - TEST-START | dromaeo_css 18:18:57 INFO - operating with platform_type : linux_ 18:18:57 INFO - Initialising browser for dromaeo_css test... 18:18:57 INFO - TEST-INFO | started process 25856 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGdyYKN/profile http://localhost:34971/getInfo.html) 18:19:00 INFO - PROCESS | 25856 | __metrics Screen width/height:1600/1200 18:19:00 INFO - PROCESS | 25856 | colorDepth:24 18:19:00 INFO - PROCESS | 25856 | Browser inner width/height: 1024/697 18:19:00 INFO - PROCESS | 25856 | __metrics 18:19:01 INFO - PROCESS | 25856 | 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" 18:19:01 INFO - PROCESS | 25856 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:19:01 INFO - PROCESS | 25856 | console.error: PushService: 18:19:01 INFO - PROCESS | 25856 | stateChangeProcessEnqueue: Error transitioning state 18:19:01 INFO - PROCESS | 25856 | UnknownError 18:19:02 INFO - TEST-INFO | 25856: exit 0 18:19:02 INFO - Browser initialized. 18:19:02 INFO - Running cycle 1/1 for dromaeo_css test... 18:19:02 INFO - TEST-INFO | started process 25949 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGdyYKN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:19:14 INFO - PROCESS | 25949 | RSS: Main: 144527360 18:19:14 INFO - PROCESS | 25949 | 18:20:05 INFO - PROCESS | 25949 | 1483410005658 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:22:15 INFO - PROCESS | 25949 | Cycle 1(1): loaded http://localhost:34971/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34971/tests/dromaeo/cssquery-ext.html) 18:22:16 INFO - PROCESS | 25949 | RSS: Main: 240590848 18:22:16 INFO - PROCESS | 25949 | 18:25:19 INFO - PROCESS | 25949 | Cycle 1(1): loaded http://localhost:34971/tests/dromaeo/cssquery-ext.html (next: http://localhost:34971/tests/dromaeo/cssquery-jquery.html) 18:25:19 INFO - PROCESS | 25949 | RSS: Main: 228601856 18:25:19 INFO - PROCESS | 25949 | 18:28:21 INFO - PROCESS | 25949 | Cycle 1(1): loaded http://localhost:34971/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34971/tests/dromaeo/cssquery-mootools.html) 18:28:22 INFO - PROCESS | 25949 | RSS: Main: 234328064 18:28:22 INFO - PROCESS | 25949 | 18:31:24 INFO - PROCESS | 25949 | Cycle 1(1): loaded http://localhost:34971/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34971/tests/dromaeo/cssquery-prototype.html) 18:31:24 INFO - PROCESS | 25949 | RSS: Main: 216850432 18:31:24 INFO - PROCESS | 25949 | 18:34:27 INFO - PROCESS | 25949 | Cycle 1(1): loaded http://localhost:34971/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34971/tests/dromaeo/cssquery-yui.html) 18:34:28 INFO - PROCESS | 25949 | RSS: Main: 175980544 18:34:28 INFO - PROCESS | 25949 | 18:37:30 INFO - PROCESS | 25949 | Cycle 1(1): loaded http://localhost:34971/tests/dromaeo/cssquery-yui.html (next: http://localhost:34971/tests/dromaeo/cssquery-dojo.html) 18:37:30 INFO - PROCESS | 25949 | RSS: Main: 267984896 18:37:30 INFO - PROCESS | 25949 | 18:37:30 INFO - PROCESS | 25949 | __start_tp_report 18:37:30 INFO - PROCESS | 25949 | _x_x_mozilla_page_load 18:37:30 INFO - PROCESS | 25949 | _x_x_mozilla_page_load_details 18:37:30 INFO - PROCESS | 25949 | |i|pagename|runs| 18:37:30 INFO - PROCESS | 25949 | |0;dojo.html;3187.713105820476;3228.0315905228426;3245.0751535812296;3265.7224135948445;3286.1784553861535;5489.313835770528;5548;5572.58205634578;5581.888362232758;5604.327480702316;5522.751476183571;5612.354579223391;5620.634658747189;5637.154426835977;5640.407757185488;5046.343975283217;5071.036503064406;5092.185250359943;5137.922931156036;5155;4827.25177597473;4853.247746599282;5111.4121875984365;5158.74206289684;5158.742062896859;4969.378827646544;5009.699418034911;5011.799528018875;5020.121478741224;5021.723805190713;5048.217526283432;5067.923981140286;5116.590672746172;5132.28148059272;5163.664361816507;4838;4838.6371022173125;5040.395152581677;5057.165567681328;5118.897622047538;5426.810061647863;5465.617406781527;5466.207399927028;5483.4516548344845;5487.039768040577;5948.7323070461935;5985.880282394328;6009.849753756147;6042.607230530001;6048.425399587032;5832.825015249549;5901.085331773582;6013.879722405527;6083.148359229712;6102.786402475892;5472.26124473195;5509.3664228613425;5514.696691681916;5528.336599607992;5545.889082218414;5969.641821490638;5978.163057172;5983.431574000463;5990.460858522667;5999.740054588586;5665.12190610456;5706.657600543981;5781.9014387267125;5784.1902133701315;5788.5369170466265;5859.589828712034;5870.178175055496;5883.882322353529;5943.3462319144855;6001.189839371629;5897.233359663216;5900.557458190653;5901.645901245939;5903.970480147572;5910.52715782745;5740.1102829061565;5879.853003674943;5935.347111817697;5937.406259374115;5946.732397042144;4536.886577835515;4565.931511027337;4582.175208462442;4616.884577885579;4634.420697412824;4170.436991006236;4171.728837625545;4184;4187.790610469525;4189.224993376235;5648.406917273627;5678.0915053591225;5680.6591604503865;5681.659100453903;5683.744231509592;5797.681127538026;5851.590388672752;5871.4715675589405;6063.211782468251;6073.757049717962;5596.496315331639;5641.492265696107;5665.830025099253;5679.488846003796;5689.345725241567;5150.48495150482;5241.397239317527;5244.6328756987405;5245.554127899095;5262.447443018428;5971.193888824953;6042.274927008787;6240.563160578716;6241.282252540925;6260.248770147611;5846.269216347957;5952.970235148797;5964.7912323068485;6019.428154325332;6031.909521357271;6168.520511900448;6199.256089269316;6209.906851397323;6214.8135555933395;6219.036049412348;5620.1288800236025;5869.706514674334;5888.4700376966275;5889.469947704727;5909.55678324136;5701.144828275792;5883.882322353444;5894.734736936934;5911.556633252438;5999.820005399845;5827.912581311369;5855.121731740102;5856.4143585641095;5865.120231965239;5873.588848780544;5843.7370318336625;5856.004479238454;5861.824145275648;5862.413758624103;5872.5301975842685;5570.637908535932;5654.971725141512;5678.858028549319;5725.456081672234;5796.82609521715;5862.149988251765;5866.208061911588;5872.794452194153;5916.497097746567;5917.822465326047;5617.157426386075;5668.845838581313;5737.168110623853;5741.483266506035;5752.741126649227 18:37:30 INFO - PROCESS | 25949 | |1;ext.html;585.9472647461728;615.4952938590355;643.0836058616471;653.2552889705739;661.9805499530723;32702.67297327026;32976.505352419736;44053.559464405305;44373.55626443735;44501.77749111258;40754.59245407545;44604.55395446045;44661.55338446615;44679.77660111703;44740.328895066516;8762.079981601919;8862.778430539223;8910.420822646507;8912.777180570472;8919.375643704943;8208.302294304991;8408.747737567852;10421.583136674524;10700.839487407695;10713.357198568072;10836.837447438294;10897.67306980792;10907.34555926643;10919.181061420386;10925.945370273137;10730;10800.297980631312;10804.621838235664;10818;10824.51289691958;10564.366138031743;10619;10619.94690026545;10629.73425664357;10632.043116119587;42371.57628423738;42710.35934460985;42849.143017139795;42925.141497170196;42971.14057718828;3602.081469225357;3696.5564132304025;4190.497140343148;4283.87148385549;4326.113146804929;30313.93901213447;30811;30821;30831.691683083107;31218.687813121804;4160.583941605845;4358.978205108954;4371.737695738266;4373.779139522685;4417.801198946023;371515;373263;375323;375692;377549;63668.68165659142;64084.67957660275;64108.35891641117;64143.67928160329;64335.678321609026;38804.80597597051;39076;39376.60623393787;41237.1752564947;66051.33948660451;18118.818811811976;18292.08539573016;18292.542686432946;18302.908485457487;18311;11999.580014699444;12039.939800300943;13991.720165596835;14109.78835317471;14111.082779619292;19347.12937917797;19583;19826.711263767807;20781.792182078287;20893.686594701092;7348.52234604749;7401.851962960711;7437.293457121565;7455.627218639046;7631.130373058636;957.5738796235747;1090.738222826516;1104.320842681745;1110.4059328259343;1167.8598568171874;33781.49327760086;34177.658223417944;34868.82565587156;35003.649963500546;36339.27321453556;1108.3682301088463;1127.3292391027326;1134.3808875213224;1188.3464094747853;1211.3882489343002;17168.570785730455;17311.82688173102;17353.56616084608;17556.5610859727;17569.47291581229;534707;538136;540423;540553;542549;58055.70972145112;58504.41495585075;58595;58596;58637;1323.6955500235;1353.7563238617142;1356.7015256643326;1441.3730027438098;1453.1716921354937;30410.239744006576;33972.66027339794;34102.82948585241;36216.63783362238;36432.63567364292;57282.71358643347;57956;58046.4195358041;58097.4190258092;58099.4190058094;506599;509734;510516;512599;512767;29455.26361840971;29816.70183298139;32269.67730322667;32612.836935816118;32685.182870427478;46128.30807537823;46483.767581161876;46674;46768.766156170364;47829;40152;40215;40221;40224.1955160901;41757.37363939604;39348.803255983534;39372.60627393689;39618.60381396149;40165;41412.1717565653;40320.596794031684;40689.59310406858;40822.79588602038;41368.965775855846;41588.16823663449;33989;36166.27667446689;36722.8163859179;36855;37136.188015134736;28134.364764095255;28135.655471235532;28253.654049946752;30318.393632127674;30869.536956945216 18:37:30 INFO - PROCESS | 25949 | |2;jquery.html;402.73419543101556;417.3281017561725;419.12612203555585;433.55993666428583;454.94085768850044;15578.376864925403;19119.426417207487;20083;20289.086991085398;20373.796262037376;20106.899465502687;20403.897980510075;20550.38348849537;20569.4857628559;20977.58044839102;5728.283964504427;5742.79900203493;5952.107183922403;5953.70231488426;5957.523398128139;5786.768529258825;5921.230240068807;5929.140274660172;5933.821985340447;5934.673592952386;5688.687122208277;5798.217240672498;5860.794872179475;5865.736041878125;5866.560007999396;5804.100364443518;5852.180694702745;5868.23712917318;5871.706414679292;5887.705614719268;5067.214581739836;5243.134882744343;5245.134552798783;5263.657862238981;5346.572274218092;24355.634665480033;24732.381690457703;24858.5028299433;24980.3754906127;25084.623730644056;2268.8184945204343;2384.1655420602824;2469.9873052048574;2582.728813474577;2661.680598328213;13995.580132595936;14586.854131458656;14738.189399583018;15006.099634021994;15376.154311512862;1736.4616968739606;1791.8711211936397;1803.107461806401;1809.5204770735766;1853.369854249548;90667.54666226692;93165;93662.53168734112;94128.99999999932;94526.99999999932;9926.751831204134;10811.675649730521;11304.491297891615;11493.770124597628;11696.824547631792;13830.23933683637;14126.152430854181;14153.787693184611;14222.502212422516;14656.534346565471;8444.493330400195;8581.828363432822;8652.653893844301;8751.91248087511;8771.692990745294;8557.786055348666;8595.441296315845;8769.210771030637;8799.956000220085;9009.369344145978;6823.863522729517;6907.447404207752;6917.481188910751;6924.619145947021;7091.787246382617;1839.0620783400561;1857.7860301677902;1875.6623807714743;1890.5840715042668;1915.339207973247;976.4775844922932;1024.9077583017565;1036.533559898034;1056.2025670618634;1110.267223632415;19969.20123195056;20430.284940027028;20682.896585517276;21045.579088418144;21295.36113916585;1004.8392257238953;1026.984595231072;1029.3735897282277;1039.870016247969;1051.3008849115406;11125.388103654377;11908.642740717793;11975.071812660937;12018.939905300418;12064.638060858188;463144;480591;487485;489606;496466;80600;85848;86104.13895861087;86742.56628716816;88346;1046.3408052926607;1048.6801525534786;1068.732816795801;1078.5146683992234;1104.640991677724;18148.546286342946;18458.723119152954;18633.53416164607;18658.253669853053;18792;31067;43050.78474607732;44926;45322;46468;58284;59252.70373648104;60202;60382.39617603768;60641;8753.518556479456;8898.822023559622;8911.821763564822;9172.724818255463;9306.06939306064;12801.42393592272;14043.789343160066;14124.50564230247;14135.43458261658;14436.133831970115;12137.150399471951;12220.327881966577;12259.754804903674;12293.815592765937;12976.15654982423;11474.77050459003;11716.355600442057;11908;11911.3448760319;12218.938905305416;12075.637730868088;12112.636620901387;12227.205231659913;12719.300438475973;12794.168379055332;8867.334949878656;8871.689490867788;8905.332100092648;9037.77405564866;9325.626974920928;11129.888701112885;11613.709657258636;11781.76436471283;11858.229215100991;12043.578474753693 18:37:30 INFO - PROCESS | 25949 | |3;mootools.html;1341.2563667232596;1460.9050411723238;1523.4058717100331;1636.8936019158755;1821.9271229150834;7517.774466765992;8305.169483051692;8496.107908669586;8589.098144694795;8771.780705482366;8421.368397370206;8522.488650680963;8527;8549.487030778158;8664.350173736964;2439.121916110199;2460.052879641333;2466.580681284186;2471.653968444419;2471.789897858684;2377.240841777081;2486.502699460106;2487.7263501014872;2492.6011838105906;2492.713337966139;2413.4690368118986;2425.648280999254;2471.9752802472017;2473.3816545863533;2479.0827393864297;2317.5480781247666;2366.597678394677;2371.5494056129364;2374.8812559371963;2411.6985376827897;2396.5206958608346;2414.1550457339968;2419.3709635494724;2420.165043060141;2421.8546887186826;8648.43785153963;8711.172438618321;8720.8691869622;8745.693900713444;8753.299736021103;5350.9732451337495;5502.752376143083;5503.944960550383;5505.03661859173;5559.638623489501;3383.0696558446625;3411.9147021324416;3479.391106556368;3502.702270307027;3686.907827304312;1088.1403691084033;1089.145021158387;1092.0881064311309;1106.1980064453207;1119.6361182615683;11592.942035289854;11694.707632309175;11800.291982480992;11805.881941180563;11812.40937953099;4925.729084900293;4951.158303088484;5048.949510504922;5078.619103567247;5104.591632669451;10428.061474467182;10429.426381549089;10441.68674939753;10441.947790261;10459.947700261602;5659.151127330933;5686.2039314496005;5690.715464226772;5694.544436445074;5697.772089116472;4263.275243208662;4571.565701258375;4637.281221410687;5030.496950304941;5080.669756465818;4132.628063474302;4159.646430053419;4255.87232383029;4289.206496798102;4308.2460569400855;1301.5899991502647;1307.895368370528;1378.9655258618413;1379.8827099696437;1390.7288078824733;978.7960511665855;987.6740675577042;1001.7445551384351;1003.227514813604;1015.1168483419473;5868.618539794899;5998.640081595031;6168.506519478431;6211.3478084801345;6232;494.6809307996322;507.4266079330333;517.6376536424518;519.721948757413;993.2153598657125;3978.8806335809973;4056.918861622751;4073.327900896378;4107.178564287155;4236.9364459533135;10651.573937042587;10778.946105269424;10878.129749620011;10881.075108615698;10909.83635245472;10578.735531611772;10855.728606784736;10874.293170943864;10880.72798180036;10911.672649820519;8166.836663266701;8392.706255281037;8419.36854735885;8443.240108390275;8458.534780587126;5992.610480318765;6024;6071.544634152545;6078.848028799315;6137.723802428812;9628.085331893459;9845.45849978258;9899.554520046759;9934.801303973736;10043.849342259726;8784.868226976729;8956.776080598038;9970.50147492637;10095.141912937188;10393.42836143989;8052.758417247492;8149.918500814916;8187.26314631686;8368.87446688288;8420.789480263042;8528.616212270586;8599.054104048424;8635.179657932485;8643.87034194475;8644.049154592863;7541.396688265036;7546.358559522502;7550.697972081055;7714.4599878008;7741.535507869546;7344.449166312441;7513.699452021858;7595.506292090997;7624.809379765328;7671.731489397845;6991.930080699128;7170.96414517924;7171.8565628688175;7173.10336207974;7192.31672991065;5180.948190518046;5289.523942845162;5345.786168553214;5369.382521010134;5510.972445137749;5315.149576067811;5318.7074710891275;5320.893582128413;5396.568274537949;5406.756695948613 18:37:30 INFO - PROCESS | 25949 | |4;prototype.html;346.1830081008819;350.57405252618065;354.97058530262234;368.1477379865611;369.34441366574345;5128.53843154116;5236.842894713155;5335.66608347913;5363.356397232333;5401.758944633218;5075.492450754923;5201.349831271091;5218.877941242632;5220.817271395502;5228.372595288571;4203.936940945889;4215.135897141094;4216.4940207175105;4217.283061879472;4230.619244268015;4032.697547683935;4137.731047481919;4225.598568136023;4227.154569086179;4234.835420259423;4060.979695101535;4129.132882094764;4136.565660605638;4157.417961485395;4157.625813676768;4112.979435102835;4115.773632450214;4129.401236820644;4133.772642504661;4154.563770804082;3536.717062634983;3640.4175331946763;3662.066173125836;3665.4135338345736;3678.172411207457;5115.565176959963;5129.794498292936;5133.640645154841;5141.897162056738;5154.4587818278915;4728.196206644879;4743.786529606142;4760.738159401231;4766.904661906777;4769.928451073237;5413.83758487246;5492.670439773627;5516.310461192351;5529.557635389159;5537.861553461155;4046.9392959105635;4047.655949244318;4059.7361171523758;4062.0502158963864;4069.7965101744794;5675.5743319250805;5677.772889084432;5679.801206957736;5716.628419152742;5755.366909639978;3972.708869617386;4100.897477563025;4116;4119.217348703737;4135.069609337875;4149.481314835645;4160.979195104005;4166.708330416903;4174.436451079066;4178.958210417918;4720.693154944917;4724.267738500538;4725.810967561328;4734.313524538922;4749.480166346736;5315.867103322371;5520.019189637551;5536.252605898152;5540.445955404508;5555.8888822223325;1346.8181795457683;1378.5657517881834;1379.165604809076;1401.8948578856628;1414.4017260495575;941.7286663004888;965.826520777259;975.6389836178491;978.9021097890296;983.4443539400216;5060.620453466005;5083.771230294646;5085.364329458817;5120.48795120485;5152.896942061137;5399.163129714901;5419.512243898068;5428.511433970962;5460.726963651801;5478.780848766084;4887.283771160847;5118.411382690963;5139.460356662496;5151.278820965068;5157.029087602525;2884.9134525964255;2903.8112522685956;2903.867491678247;2912.4466351393166;2915.6792752797173;5544.22380866679;5560.666360018412;5573.721313934287;5607.15909601924;5618.6628802272;5264.42091369949;5450.727463626803;5473.318074143641;5497.285352904097;5535.667859928337;5585.58108141891;5588.552915766729;5600.05996851648;5612.663240205601;5615.691136987505;5139.794408223629;5416.9729151353995;5417.268668729671;5447.509724124848;5448.346198456211;5377.064256867447;5410.756515956713;5426.782928682808;5431.565474762088;5432.728363581884;5649.802256920988;5651.802186923438;5654.971725141512;5663.423142470084;5674.4892959633835;3897.5517815451585;4024.510930955565;4036.3340048891605;4036.6367026967714;4051.716379853382;5392.7573259202645;5404.567634589302;5412.702301373462;5434.728263586726;5449.918251226314;5416.647917885325;5437.265969094122;5472.398036215934;5523.8066667666435;5527.088030474926;5489.176623506506;5503.651605356713;5511.283533140666;5526.005319042611;5542.584306176972;5278.516179321629;5458;5458.590605704509;5473.233747275464;5473.288472498709;5523.2819733436;5537.916931246115;5544.223808666709;5551.722413879371;5557.805476808292;5394.649347792381;5407.486288802557;5425.810096646598;5427.348718153847;5442.972785136049 18:37:30 INFO - PROCESS | 25949 | |5;yui.html;807.3903459890533;809.4374409785198;852.3309202276214;860.4536119564077;865.7705707987388;15035;16019.279132439053;16052.43816466424;16058.518244452656;16062.678746425065;14815.481458148966;14950.925245373784;14960.251987400641;14966.32651530681;14973.625659358495;712.5332906945958;725.383424089525;846.699421705295;871.8517851965149;887.0641473245723;866.3891956170916;880.1418616848554;880.5905254056862;881.1100788203928;881.3037700216853;926.115559640545;927.4574373991223;927.5918595817852;928.6192661008988;928.767808047988;760.6006846405626;763.6792547130219;865.8008658008694;922.4649703172178;924.3437159616681;624.4629618528062;647.6276141218771;647.757091090841;647.9611223326616;647.9902801457982;14996.25018749069;15023.248837558078;15029.849701503064;15039.774403383957;15102.848971510253;12561.309127997956;12836.294003829786;12953.158044727063;13045.934770326088;13117.934410327982;11178.217524773268;11204.439778011067;11295.49170287339;11354.60258890943;11424.143189260838;4137.565555616678;4142.647874930634;4171.770552619605;4186.748795072305;4195.727277726968;65651.343486565;67066;67255;69090;69229.65385173092;10307.278490505743;10427.061564459234;10427.530761115768;10458.738531536772;10501.9474902625;21711.565768684854;21734.89132554327;21764.564708706053;21955.67066494004;22321.776782232293;8101.675932962733;8326.791830204173;8363.623636936352;8392.538410387488;8428.157184281523;4483.327500874895;4506.526814684476;4610.492845786961;4636.281376386665;4717.103750287434;3444.3111377724554;3522.63012383696;3560.127768696686;3562.109472631842;3569.625189355132;573.2919843992665;573.4408951272476;585.3970410477215;595.9463648271676;611.7461253579803;653.7450394346209;663.8473151175257;697.9092717946736;717.3221305866011;724.641302555228;8581.95709021451;8638.453003645565;8713.738587842376;8896.688615898542;9033.412828166149;667.6227931218846;683.9658017099125;684.9178098628197;690.7202582953811;734.2583990169967;4113.259613269581;4182.623563879265;4191.559886211904;4220.134872351222;4250.234957707642;51619.741901291;55627;91413.54293228491;96910.51544742231;97968;65988;71927.6403617989;72946.27053729501;74513.25486745063;76906;48593.757031215326;48789.02421951541;61808.690956545826;67722.3227767716;68035.65982170157;8332.50004999702;8504.489730616182;8601.311895048257;9125.954370228106;9654.75863103428;44474.555254448336;45266.54733452755;45516;45885.77057114693;46172;61603.69198153981;64469.355306446334;65592.67203663952;66272;68999.3100068993;10951.178661600572;11223.214374993671;11345.659630211107;11695.707607309885;11773.117016223647;12470.5011799527;12630.494780208688;12741.936290318488;12781.936090319861;12858.67853303675;12151.81772273399;12174.452149653463;12441.63188100078;12714.300713460849;12752.234865908074;12421.813672794735;12685.682857928625;12782.61652150437;13065.738685226052;13210.339483026002;11878.643640690792;11974.58088966882;12290.078244131548;12495.750084998432;12591.118621696392;9687.176589989647;9749.610015599297;9964.950175249078;9995.118014526664;10084.495775211064;8854.955725221333;9329.346945713734;10003.29976901639;10168.694939151837;10235.7441063974 18:37:30 INFO - PROCESS | 25949 | __end_tp_report 18:37:30 INFO - PROCESS | 25949 | __start_cc_report 18:37:30 INFO - PROCESS | 25949 | _x_x_mozilla_cycle_collect,1039 18:37:30 INFO - PROCESS | 25949 | __end_cc_report 18:37:30 INFO - PROCESS | 25949 | __startTimestamp1483411050915__endTimestamp 18:37:30 INFO - PROCESS | 25949 | 18:37:30 INFO - PROCESS | 25949 | ------- Summary: start ------- 18:37:30 INFO - PROCESS | 25949 | Number of tests: 6 18:37:30 INFO - PROCESS | 25949 | 18:37:30 INFO - PROCESS | 25949 | [#0] dojo.html Cycles:165 Average:5524.42 Median:5701.14 stddev:612.75 (10.7%) stddev-sans-first:586.57 18:37:30 INFO - PROCESS | 25949 | Values: 3187.7 3228.0 3245.1 3265.7 3286.2 5489.3 5548.0 5572.6 5581.9 5604.3 5522.8 5612.4 5620.6 5637.2 5640.4 5046.3 5071.0 5092.2 5137.9 5155.0 4827.3 4853.2 5111.4 5158.7 5158.7 4969.4 5009.7 5011.8 5020.1 5021.7 5048.2 5067.9 5116.6 5132.3 5163.7 4838.0 4838.6 5040.4 5057.2 5118.9 5426.8 5465.6 5466.2 5483.5 5487.0 5948.7 5985.9 6009.8 6042.6 6048.4 5832.8 5901.1 6013.9 6083.1 6102.8 5472.3 5509.4 5514.7 5528.3 5545.9 5969.6 5978.2 5983.4 5990.5 5999.7 5665.1 5706.7 5781.9 5784.2 5788.5 5859.6 5870.2 5883.9 5943.3 6001.2 5897.2 5900.6 5901.6 5904.0 5910.5 5740.1 5879.9 5935.3 5937.4 5946.7 4536.9 4565.9 4582.2 4616.9 4634.4 4170.4 4171.7 4184.0 4187.8 4189.2 5648.4 5678.1 5680.7 5681.7 5683.7 5797.7 5851.6 5871.5 6063.2 6073.8 5596.5 5641.5 5665.8 5679.5 5689.3 5150.5 5241.4 5244.6 5245.6 5262.4 5971.2 6042.3 6240.6 6241.3 6260.2 5846.3 5953.0 5964.8 6019.4 6031.9 6168.5 6199.3 6209.9 6214.8 6219.0 5620.1 5869.7 5888.5 5889.5 5909.6 5701.1 5883.9 5894.7 5911.6 5999.8 5827.9 5855.1 5856.4 5865.1 5873.6 5843.7 5856.0 5861.8 5862.4 5872.5 5570.6 5655.0 5678.9 5725.5 5796.8 5862.1 5866.2 5872.8 5916.5 5917.8 5617.2 5668.8 5737.2 5741.5 5752.7 18:37:30 INFO - PROCESS | 25949 | 18:37:30 INFO - PROCESS | 25949 | [#1] ext.html Cycles:180 Average:63356.11 Median:208176.90 stddev:127399.50 (61.2%) stddev-sans-first:127669.72 18:37:30 INFO - PROCESS | 25949 | Values: 585.9 615.5 643.1 653.3 662.0 32702.7 32976.5 44053.6 44373.6 44501.8 40754.6 44604.6 44661.6 44679.8 44740.3 8762.1 8862.8 8910.4 8912.8 8919.4 8208.3 8408.7 10421.6 10700.8 10713.4 10836.8 10897.7 10907.3 10919.2 10925.9 10730.0 10800.3 10804.6 10818.0 10824.5 10564.4 10619.0 10619.9 10629.7 10632.0 42371.6 42710.4 42849.1 42925.1 42971.1 3602.1 3696.6 4190.5 4283.9 4326.1 30313.9 30811.0 30821.0 30831.7 31218.7 4160.6 4359.0 4371.7 4373.8 4417.8 371515.0 373263.0 375323.0 375692.0 377549.0 63668.7 64084.7 64108.4 64143.7 64335.7 38804.8 39076.0 39376.6 41237.2 66051.3 18118.8 18292.1 18292.5 18302.9 18311.0 11999.6 12039.9 13991.7 14109.8 14111.1 19347.1 19583.0 19826.7 20781.8 20893.7 7348.5 7401.9 7437.3 7455.6 7631.1 957.6 1090.7 1104.3 1110.4 1167.9 33781.5 34177.7 34868.8 35003.6 36339.3 1108.4 1127.3 1134.4 1188.3 1211.4 17168.6 17311.8 17353.6 17556.6 17569.5 534707.0 538136.0 540423.0 540553.0 542549.0 58055.7 58504.4 58595.0 58596.0 58637.0 1323.7 1353.8 1356.7 1441.4 1453.2 30410.2 33972.7 34102.8 36216.6 36432.6 57282.7 57956.0 58046.4 58097.4 58099.4 506599.0 509734.0 510516.0 512599.0 512767.0 29455.3 29816.7 32269.7 32612.8 32685.2 46128.3 46483.8 46674.0 46768.8 47829.0 40152.0 40215.0 40221.0 40224.2 41757.4 39348.8 39372.6 39618.6 40165.0 41412.2 40320.6 40689.6 40822.8 41369.0 41588.2 33989.0 36166.3 36722.8 36855.0 37136.2 28134.4 28135.7 28253.7 30318.4 30869.5 18:37:30 INFO - PROCESS | 25949 | 18:37:30 INFO - PROCESS | 25949 | [#2] jquery.html Cycles:180 Average:29513.78 Median:13412.81 stddev:79817.68 (595.1%) stddev-sans-first:80011.66 18:37:30 INFO - PROCESS | 25949 | Values: 402.7 417.3 419.1 433.6 454.9 15578.4 19119.4 20083.0 20289.1 20373.8 20106.9 20403.9 20550.4 20569.5 20977.6 5728.3 5742.8 5952.1 5953.7 5957.5 5786.8 5921.2 5929.1 5933.8 5934.7 5688.7 5798.2 5860.8 5865.7 5866.6 5804.1 5852.2 5868.2 5871.7 5887.7 5067.2 5243.1 5245.1 5263.7 5346.6 24355.6 24732.4 24858.5 24980.4 25084.6 2268.8 2384.2 2470.0 2582.7 2661.7 13995.6 14586.9 14738.2 15006.1 15376.2 1736.5 1791.9 1803.1 1809.5 1853.4 90667.5 93165.0 93662.5 94129.0 94527.0 9926.8 10811.7 11304.5 11493.8 11696.8 13830.2 14126.2 14153.8 14222.5 14656.5 8444.5 8581.8 8652.7 8751.9 8771.7 8557.8 8595.4 8769.2 8800.0 9009.4 6823.9 6907.4 6917.5 6924.6 7091.8 1839.1 1857.8 1875.7 1890.6 1915.3 976.5 1024.9 1036.5 1056.2 1110.3 19969.2 20430.3 20682.9 21045.6 21295.4 1004.8 1027.0 1029.4 1039.9 1051.3 11125.4 11908.6 11975.1 12018.9 12064.6 463144.0 480591.0 487485.0 489606.0 496466.0 80600.0 85848.0 86104.1 86742.6 88346.0 1046.3 1048.7 1068.7 1078.5 1104.6 18148.5 18458.7 18633.5 18658.3 18792.0 31067.0 43050.8 44926.0 45322.0 46468.0 58284.0 59252.7 60202.0 60382.4 60641.0 8753.5 8898.8 8911.8 9172.7 9306.1 12801.4 14043.8 14124.5 14135.4 14436.1 12137.2 12220.3 12259.8 12293.8 12976.2 11474.8 11716.4 11908.0 11911.3 12218.9 12075.6 12112.6 12227.2 12719.3 12794.2 8867.3 8871.7 8905.3 9037.8 9325.6 11129.9 11613.7 11781.8 11858.2 12043.6 18:37:30 INFO - PROCESS | 25949 | 18:37:30 INFO - PROCESS | 25949 | [#3] mootools.html Cycles:180 Average:5827.70 Median:5079.64 stddev:3216.25 (63.3%) stddev-sans-first:3207.60 18:37:30 INFO - PROCESS | 25949 | Values: 1341.3 1460.9 1523.4 1636.9 1821.9 7517.8 8305.2 8496.1 8589.1 8771.8 8421.4 8522.5 8527.0 8549.5 8664.4 2439.1 2460.1 2466.6 2471.7 2471.8 2377.2 2486.5 2487.7 2492.6 2492.7 2413.5 2425.6 2472.0 2473.4 2479.1 2317.5 2366.6 2371.5 2374.9 2411.7 2396.5 2414.2 2419.4 2420.2 2421.9 8648.4 8711.2 8720.9 8745.7 8753.3 5351.0 5502.8 5503.9 5505.0 5559.6 3383.1 3411.9 3479.4 3502.7 3686.9 1088.1 1089.1 1092.1 1106.2 1119.6 11592.9 11694.7 11800.3 11805.9 11812.4 4925.7 4951.2 5048.9 5078.6 5104.6 10428.1 10429.4 10441.7 10441.9 10459.9 5659.2 5686.2 5690.7 5694.5 5697.8 4263.3 4571.6 4637.3 5030.5 5080.7 4132.6 4159.6 4255.9 4289.2 4308.2 1301.6 1307.9 1379.0 1379.9 1390.7 978.8 987.7 1001.7 1003.2 1015.1 5868.6 5998.6 6168.5 6211.3 6232.0 494.7 507.4 517.6 519.7 993.2 3978.9 4056.9 4073.3 4107.2 4236.9 10651.6 10778.9 10878.1 10881.1 10909.8 10578.7 10855.7 10874.3 10880.7 10911.7 8166.8 8392.7 8419.4 8443.2 8458.5 5992.6 6024.0 6071.5 6078.8 6137.7 9628.1 9845.5 9899.6 9934.8 10043.8 8784.9 8956.8 9970.5 10095.1 10393.4 8052.8 8149.9 8187.3 8368.9 8420.8 8528.6 8599.1 8635.2 8643.9 8644.0 7541.4 7546.4 7550.7 7714.5 7741.5 7344.4 7513.7 7595.5 7624.8 7671.7 6991.9 7171.0 7171.9 7173.1 7192.3 5180.9 5289.5 5345.8 5369.4 5511.0 5315.1 5318.7 5320.9 5396.6 5406.8 18:37:30 INFO - PROCESS | 25949 | 18:37:30 INFO - PROCESS | 25949 | [#4] prototype.html Cycles:180 Average:4597.69 Median:5224.59 stddev:1316.29 (25.2%) stddev-sans-first:1280.71 18:37:30 INFO - PROCESS | 25949 | Values: 346.2 350.6 355.0 368.1 369.3 5128.5 5236.8 5335.7 5363.4 5401.8 5075.5 5201.3 5218.9 5220.8 5228.4 4203.9 4215.1 4216.5 4217.3 4230.6 4032.7 4137.7 4225.6 4227.2 4234.8 4061.0 4129.1 4136.6 4157.4 4157.6 4113.0 4115.8 4129.4 4133.8 4154.6 3536.7 3640.4 3662.1 3665.4 3678.2 5115.6 5129.8 5133.6 5141.9 5154.5 4728.2 4743.8 4760.7 4766.9 4769.9 5413.8 5492.7 5516.3 5529.6 5537.9 4046.9 4047.7 4059.7 4062.1 4069.8 5675.6 5677.8 5679.8 5716.6 5755.4 3972.7 4100.9 4116.0 4119.2 4135.1 4149.5 4161.0 4166.7 4174.4 4179.0 4720.7 4724.3 4725.8 4734.3 4749.5 5315.9 5520.0 5536.3 5540.4 5555.9 1346.8 1378.6 1379.2 1401.9 1414.4 941.7 965.8 975.6 978.9 983.4 5060.6 5083.8 5085.4 5120.5 5152.9 5399.2 5419.5 5428.5 5460.7 5478.8 4887.3 5118.4 5139.5 5151.3 5157.0 2884.9 2903.8 2903.9 2912.4 2915.7 5544.2 5560.7 5573.7 5607.2 5618.7 5264.4 5450.7 5473.3 5497.3 5535.7 5585.6 5588.6 5600.1 5612.7 5615.7 5139.8 5417.0 5417.3 5447.5 5448.3 5377.1 5410.8 5426.8 5431.6 5432.7 5649.8 5651.8 5655.0 5663.4 5674.5 3897.6 4024.5 4036.3 4036.6 4051.7 5392.8 5404.6 5412.7 5434.7 5449.9 5416.6 5437.3 5472.4 5523.8 5527.1 5489.2 5503.7 5511.3 5526.0 5542.6 5278.5 5458.0 5458.6 5473.2 5473.3 5523.3 5537.9 5544.2 5551.7 5557.8 5394.6 5407.5 5425.8 5427.3 5443.0 18:37:30 INFO - PROCESS | 25949 | 18:37:30 INFO - PROCESS | 25949 | [#5] yui.html Cycles:180 Average:17265.77 Median:50204.38 stddev:22714.40 (45.2%) stddev-sans-first:22744.50 18:37:30 INFO - PROCESS | 25949 | Values: 807.4 809.4 852.3 860.5 865.8 15035.0 16019.3 16052.4 16058.5 16062.7 14815.5 14950.9 14960.3 14966.3 14973.6 712.5 725.4 846.7 871.9 887.1 866.4 880.1 880.6 881.1 881.3 926.1 927.5 927.6 928.6 928.8 760.6 763.7 865.8 922.5 924.3 624.5 647.6 647.8 648.0 648.0 14996.3 15023.2 15029.8 15039.8 15102.8 12561.3 12836.3 12953.2 13045.9 13117.9 11178.2 11204.4 11295.5 11354.6 11424.1 4137.6 4142.6 4171.8 4186.7 4195.7 65651.3 67066.0 67255.0 69090.0 69229.7 10307.3 10427.1 10427.5 10458.7 10501.9 21711.6 21734.9 21764.6 21955.7 22321.8 8101.7 8326.8 8363.6 8392.5 8428.2 4483.3 4506.5 4610.5 4636.3 4717.1 3444.3 3522.6 3560.1 3562.1 3569.6 573.3 573.4 585.4 595.9 611.7 653.7 663.8 697.9 717.3 724.6 8582.0 8638.5 8713.7 8896.7 9033.4 667.6 684.0 684.9 690.7 734.3 4113.3 4182.6 4191.6 4220.1 4250.2 51619.7 55627.0 91413.5 96910.5 97968.0 65988.0 71927.6 72946.3 74513.3 76906.0 48593.8 48789.0 61808.7 67722.3 68035.7 8332.5 8504.5 8601.3 9126.0 9654.8 44474.6 45266.5 45516.0 45885.8 46172.0 61603.7 64469.4 65592.7 66272.0 68999.3 10951.2 11223.2 11345.7 11695.7 11773.1 12470.5 12630.5 12741.9 12781.9 12858.7 12151.8 12174.5 12441.6 12714.3 12752.2 12421.8 12685.7 12782.6 13065.7 13210.3 11878.6 11974.6 12290.1 12495.8 12591.1 9687.2 9749.6 9965.0 9995.1 10084.5 8855.0 9329.3 10003.3 10168.7 10235.7 18:37:30 INFO - PROCESS | 25949 | -------- Summary: end -------- 18:37:30 INFO - PROCESS | 25949 | 18:37:31 INFO - TEST-INFO | 25949: exit 0 18:37:31 INFO - TEST-OK | dromaeo_css | took 1114702ms 18:37:31 INFO - TEST-START | kraken 18:37:31 INFO - operating with platform_type : linux_ 18:37:31 INFO - Initialising browser for kraken test... 18:37:31 INFO - TEST-INFO | started process 26279 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp094qMS/profile http://localhost:34971/getInfo.html) 18:37:35 INFO - PROCESS | 26279 | __metrics Screen width/height:1600/1200 18:37:35 INFO - PROCESS | 26279 | colorDepth:24 18:37:35 INFO - PROCESS | 26279 | Browser inner width/height: 1024/697 18:37:35 INFO - PROCESS | 26279 | __metrics 18:37:35 INFO - PROCESS | 26279 | 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" 18:37:35 INFO - PROCESS | 26279 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:37:36 INFO - PROCESS | 26279 | console.error: PushService: 18:37:36 INFO - PROCESS | 26279 | stateChangeProcessEnqueue: Error transitioning state 18:37:36 INFO - PROCESS | 26279 | UnknownError 18:37:37 INFO - TEST-INFO | 26279: exit 0 18:37:37 INFO - Browser initialized. 18:37:37 INFO - Running cycle 1/1 for kraken test... 18:37:37 INFO - TEST-INFO | started process 26373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp094qMS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:37:48 INFO - PROCESS | 26373 | RSS: Main: 144609280 18:37:48 INFO - PROCESS | 26373 | 18:37:51 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:34971/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34971/tests/kraken/driver.html?testName=audio-beat-detection) 18:37:52 INFO - PROCESS | 26373 | RSS: Main: 186372096 18:37:52 INFO - PROCESS | 26373 | 18:37:54 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:34971/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34971/tests/kraken/driver.html?testName=audio-dft) 18:37:55 INFO - PROCESS | 26373 | RSS: Main: 175398912 18:37:55 INFO - PROCESS | 26373 | 18:37:58 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:34971/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34971/tests/kraken/driver.html?testName=audio-fft) 18:37:58 INFO - PROCESS | 26373 | RSS: Main: 267132928 18:37:58 INFO - PROCESS | 26373 | 18:38:00 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:34971/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34971/tests/kraken/driver.html?testName=audio-oscillator) 18:38:01 INFO - PROCESS | 26373 | RSS: Main: 173424640 18:38:01 INFO - PROCESS | 26373 | 18:38:03 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:34971/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34971/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:38:04 INFO - PROCESS | 26373 | RSS: Main: 175427584 18:38:04 INFO - PROCESS | 26373 | 18:38:07 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:34971/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34971/tests/kraken/driver.html?testName=imaging-darkroom) 18:38:07 INFO - PROCESS | 26373 | RSS: Main: 214192128 18:38:07 INFO - PROCESS | 26373 | 18:38:10 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:34971/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34971/tests/kraken/driver.html?testName=imaging-desaturate) 18:38:11 INFO - PROCESS | 26373 | RSS: Main: 212897792 18:38:11 INFO - PROCESS | 26373 | 18:38:14 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:34971/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34971/tests/kraken/driver.html?testName=json-parse-financial) 18:38:14 INFO - PROCESS | 26373 | RSS: Main: 211755008 18:38:14 INFO - PROCESS | 26373 | 18:38:16 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:34971/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34971/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:38:16 INFO - PROCESS | 26373 | RSS: Main: 174428160 18:38:16 INFO - PROCESS | 26373 | 18:38:18 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:34971/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34971/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:38:19 INFO - PROCESS | 26373 | RSS: Main: 181243904 18:38:19 INFO - PROCESS | 26373 | 18:38:21 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:34971/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34971/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:38:21 INFO - PROCESS | 26373 | RSS: Main: 190099456 18:38:21 INFO - PROCESS | 26373 | 18:38:24 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:34971/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34971/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:38:25 INFO - PROCESS | 26373 | RSS: Main: 198651904 18:38:25 INFO - PROCESS | 26373 | 18:38:27 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:34971/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34971/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:38:28 INFO - PROCESS | 26373 | RSS: Main: 194859008 18:38:28 INFO - PROCESS | 26373 | 18:38:29 INFO - PROCESS | 26373 | Cycle 1(1): loaded http://localhost:34971/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34971/tests/kraken/driver.html?testName=ai-astar) 18:38:30 INFO - PROCESS | 26373 | RSS: Main: 247058432 18:38:30 INFO - PROCESS | 26373 | 18:38:30 INFO - PROCESS | 26373 | __start_tp_report 18:38:30 INFO - PROCESS | 26373 | _x_x_mozilla_page_load 18:38:30 INFO - PROCESS | 26373 | _x_x_mozilla_page_load_details 18:38:30 INFO - PROCESS | 26373 | |i|pagename|runs| 18:38:30 INFO - PROCESS | 26373 | |0;ai-astar;103;110;111;110;110;110;110;110;111;110 18:38:30 INFO - PROCESS | 26373 | |1;audio-beat-detection;148;117;120;160;121;118;119;117;147;119 18:38:30 INFO - PROCESS | 26373 | |2;audio-dft;160;161;160;163;161;160;161;162;160;162 18:38:30 INFO - PROCESS | 26373 | |3;audio-fft;74;75;75;101;75;74;75;75;107;75 18:38:30 INFO - PROCESS | 26373 | |4;audio-oscillator;82;81;114;82;83;81;108;81;81;107 18:38:30 INFO - PROCESS | 26373 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;117;116 18:38:30 INFO - PROCESS | 26373 | |6;imaging-darkroom;146;146;146;145;146;145;147;146;146;146 18:38:30 INFO - PROCESS | 26373 | |7;imaging-desaturate;86;84;85;85;84;85;85;84;84;85 18:38:30 INFO - PROCESS | 26373 | |8;json-parse-financial;52;52;53;53;53;51;53;54;53;53 18:38:30 INFO - PROCESS | 26373 | |9;json-stringify-tinderbox;58;58;59;59;60;60;58;59;59;58 18:38:30 INFO - PROCESS | 26373 | |10;stanford-crypto-aes;74;75;75;83;75;76;75;82;74;75 18:38:30 INFO - PROCESS | 26373 | |11;stanford-crypto-ccm;123;131;133;129;121;119;120;125;164;126 18:38:30 INFO - PROCESS | 26373 | |12;stanford-crypto-pbkdf2;156;157;153;156;158;153;156;154;156;154 18:38:30 INFO - PROCESS | 26373 | |13;stanford-crypto-sha256-iterative;62;62;67;66;64;62;63;63;61;59 18:38:30 INFO - PROCESS | 26373 | __end_tp_report 18:38:30 INFO - PROCESS | 26373 | __start_cc_report 18:38:30 INFO - PROCESS | 26373 | _x_x_mozilla_cycle_collect,1638 18:38:30 INFO - PROCESS | 26373 | __end_cc_report 18:38:30 INFO - PROCESS | 26373 | __startTimestamp1483411110147__endTimestamp 18:38:30 INFO - PROCESS | 26373 | 18:38:30 INFO - PROCESS | 26373 | ------- Summary: start ------- 18:38:30 INFO - PROCESS | 26373 | Number of tests: 14 18:38:30 INFO - PROCESS | 26373 | 18:38:30 INFO - PROCESS | 26373 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:2.32 (2.1%) stddev-sans-first:0.44 18:38:30 INFO - PROCESS | 26373 | Values: 103.0 110.0 111.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 18:38:30 INFO - PROCESS | 26373 | 18:38:30 INFO - PROCESS | 26373 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:120.50 stddev:16.32 (13.5%) stddev-sans-first:15.73 18:38:30 INFO - PROCESS | 26373 | Values: 148.0 117.0 120.0 160.0 121.0 118.0 119.0 117.0 147.0 119.0 18:38:30 INFO - PROCESS | 26373 | 18:38:30 INFO - PROCESS | 26373 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 18:38:30 INFO - PROCESS | 26373 | Values: 160.0 161.0 160.0 163.0 161.0 160.0 161.0 162.0 160.0 162.0 18:38:30 INFO - PROCESS | 26373 | 18:38:30 INFO - PROCESS | 26373 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.00 stddev:12.42 (16.6%) stddev-sans-first:12.94 18:38:30 INFO - PROCESS | 26373 | Values: 74.0 75.0 75.0 101.0 75.0 74.0 75.0 75.0 107.0 75.0 18:38:30 INFO - PROCESS | 26373 | 18:38:30 INFO - PROCESS | 26373 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:81.00 stddev:13.70 (16.9%) stddev-sans-first:14.23 18:38:30 INFO - PROCESS | 26373 | Values: 82.0 81.0 114.0 82.0 83.0 81.0 108.0 81.0 81.0 107.0 18:38:30 INFO - PROCESS | 26373 | 18:38:30 INFO - PROCESS | 26373 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:38:30 INFO - PROCESS | 26373 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 18:38:30 INFO - PROCESS | 26373 | 18:38:30 INFO - PROCESS | 26373 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 18:38:30 INFO - PROCESS | 26373 | Values: 146.0 146.0 146.0 145.0 146.0 145.0 147.0 146.0 146.0 146.0 18:38:30 INFO - PROCESS | 26373 | 18:38:30 INFO - PROCESS | 26373 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.67 (0.8%) stddev-sans-first:0.53 18:38:30 INFO - PROCESS | 26373 | Values: 86.0 84.0 85.0 85.0 84.0 85.0 85.0 84.0 84.0 85.0 18:38:30 INFO - PROCESS | 26373 | 18:38:30 INFO - PROCESS | 26373 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:0.82 (1.6%) stddev-sans-first:0.83 18:38:30 INFO - PROCESS | 26373 | Values: 52.0 52.0 53.0 53.0 53.0 51.0 53.0 54.0 53.0 53.0 18:38:30 INFO - PROCESS | 26373 | 18:38:30 INFO - PROCESS | 26373 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 18:38:30 INFO - PROCESS | 26373 | Values: 58.0 58.0 59.0 59.0 60.0 60.0 58.0 59.0 59.0 58.0 18:38:30 INFO - PROCESS | 26373 | 18:38:30 INFO - PROCESS | 26373 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:75.00 stddev:3.27 (4.4%) stddev-sans-first:3.35 18:38:30 INFO - PROCESS | 26373 | Values: 74.0 75.0 75.0 83.0 75.0 76.0 75.0 82.0 74.0 75.0 18:38:30 INFO - PROCESS | 26373 | 18:38:30 INFO - PROCESS | 26373 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:127.50 stddev:13.13 (10.3%) stddev-sans-first:13.74 18:38:30 INFO - PROCESS | 26373 | Values: 123.0 131.0 133.0 129.0 121.0 119.0 120.0 125.0 164.0 126.0 18:38:30 INFO - PROCESS | 26373 | 18:38:30 INFO - PROCESS | 26373 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.30 Median:156.00 stddev:1.70 (1.1%) stddev-sans-first:1.79 18:38:30 INFO - PROCESS | 26373 | Values: 156.0 157.0 153.0 156.0 158.0 153.0 156.0 154.0 156.0 154.0 18:38:30 INFO - PROCESS | 26373 | 18:38:30 INFO - PROCESS | 26373 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:2.33 (3.7%) stddev-sans-first:2.45 18:38:30 INFO - PROCESS | 26373 | Values: 62.0 62.0 67.0 66.0 64.0 62.0 63.0 63.0 61.0 59.0 18:38:30 INFO - PROCESS | 26373 | -------- Summary: end -------- 18:38:30 INFO - PROCESS | 26373 | 18:38:31 INFO - TEST-INFO | 26373: exit 0 18:38:31 INFO - TEST-OK | kraken | took 59493ms 18:38:31 INFO - SUITE-END | took 1174s 18:38:31 INFO - Completed test suite (00:19:34) 18:38:31 INFO - javascript benchmark 18:38:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3187.713105820476, 3228.0315905228426, 3245.0751535812296, 3265.7224135948445, 3286.1784553861535, 5489.313835770528, 5548.0, 5572.58205634578, 5581.888362232758, 5604.327480702316, 5522.751476183571, 5612.354579223391, 5620.634658747189, 5637.154426835977, 5640.407757185488, 5046.343975283217, 5071.036503064406, 5092.185250359943, 5137.922931156036, 5155.0, 4827.25177597473, 4853.247746599282, 5111.4121875984365, 5158.74206289684, 5158.742062896859, 4969.378827646544, 5009.699418034911, 5011.799528018875, 5020.121478741224, 5021.723805190713, 5048.217526283432, 5067.923981140286, 5116.590672746172, 5132.28148059272, 5163.664361816507, 4838.0, 4838.6371022173125, 5040.395152581677, 5057.165567681328, 5118.897622047538, 5426.810061647863, 5465.617406781527, 5466.207399927028, 5483.4516548344845, 5487.039768040577, 5948.7323070461935, 5985.880282394328, 6009.849753756147, 6042.607230530001, 6048.425399587032, 5832.825015249549, 5901.085331773582, 6013.879722405527, 6083.148359229712, 6102.786402475892, 5472.26124473195, 5509.3664228613425, 5514.696691681916, 5528.336599607992, 5545.889082218414, 5969.641821490638, 5978.163057172, 5983.431574000463, 5990.460858522667, 5999.740054588586, 5665.12190610456, 5706.657600543981, 5781.9014387267125, 5784.1902133701315, 5788.5369170466265, 5859.589828712034, 5870.178175055496, 5883.882322353529, 5943.3462319144855, 6001.189839371629, 5897.233359663216, 5900.557458190653, 5901.645901245939, 5903.970480147572, 5910.52715782745, 5740.1102829061565, 5879.853003674943, 5935.347111817697, 5937.406259374115, 5946.732397042144, 4536.886577835515, 4565.931511027337, 4582.175208462442, 4616.884577885579, 4634.420697412824, 4170.436991006236, 4171.728837625545, 4184.0, 4187.790610469525, 4189.224993376235, 5648.406917273627, 5678.0915053591225, 5680.6591604503865, 5681.659100453903, 5683.744231509592, 5797.681127538026, 5851.590388672752, 5871.4715675589405, 6063.211782468251, 6073.757049717962, 5596.496315331639, 5641.492265696107, 5665.830025099253, 5679.488846003796, 5689.345725241567, 5150.48495150482, 5241.397239317527, 5244.6328756987405, 5245.554127899095, 5262.447443018428, 5971.193888824953, 6042.274927008787, 6240.563160578716, 6241.282252540925, 6260.248770147611, 5846.269216347957, 5952.970235148797, 5964.7912323068485, 6019.428154325332, 6031.909521357271, 6168.520511900448, 6199.256089269316, 6209.906851397323, 6214.8135555933395, 6219.036049412348, 5620.1288800236025, 5869.706514674334, 5888.4700376966275, 5889.469947704727, 5909.55678324136, 5701.144828275792, 5883.882322353444, 5894.734736936934, 5911.556633252438, 5999.820005399845, 5827.912581311369, 5855.121731740102, 5856.4143585641095, 5865.120231965239, 5873.588848780544, 5843.7370318336625, 5856.004479238454, 5861.824145275648, 5862.413758624103, 5872.5301975842685, 5570.637908535932, 5654.971725141512, 5678.858028549319, 5725.456081672234, 5796.82609521715, 5862.149988251765, 5866.208061911588, 5872.794452194153, 5916.497097746567, 5917.822465326047, 5617.157426386075, 5668.845838581313, 5737.168110623853, 5741.483266506035, 5752.741126649227], "value": 5484.324098213755, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.9472647461728, 615.4952938590355, 643.0836058616471, 653.2552889705739, 661.9805499530723, 32702.67297327026, 32976.505352419736, 44053.559464405305, 44373.55626443735, 44501.77749111258, 40754.59245407545, 44604.55395446045, 44661.55338446615, 44679.77660111703, 44740.328895066516, 8762.079981601919, 8862.778430539223, 8910.420822646507, 8912.777180570472, 8919.375643704943, 8208.302294304991, 8408.747737567852, 10421.583136674524, 10700.839487407695, 10713.357198568072, 10836.837447438294, 10897.67306980792, 10907.34555926643, 10919.181061420386, 10925.945370273137, 10730.0, 10800.297980631312, 10804.621838235664, 10818.0, 10824.51289691958, 10564.366138031743, 10619.0, 10619.94690026545, 10629.73425664357, 10632.043116119587, 42371.57628423738, 42710.35934460985, 42849.143017139795, 42925.141497170196, 42971.14057718828, 3602.081469225357, 3696.5564132304025, 4190.497140343148, 4283.87148385549, 4326.113146804929, 30313.93901213447, 30811.0, 30821.0, 30831.691683083107, 31218.687813121804, 4160.583941605845, 4358.978205108954, 4371.737695738266, 4373.779139522685, 4417.801198946023, 371515.0, 373263.0, 375323.0, 375692.0, 377549.0, 63668.68165659142, 64084.67957660275, 64108.35891641117, 64143.67928160329, 64335.678321609026, 38804.80597597051, 39076.0, 39376.60623393787, 41237.1752564947, 66051.33948660451, 18118.818811811976, 18292.08539573016, 18292.542686432946, 18302.908485457487, 18311.0, 11999.580014699444, 12039.939800300943, 13991.720165596835, 14109.78835317471, 14111.082779619292, 19347.12937917797, 19583.0, 19826.711263767807, 20781.792182078287, 20893.686594701092, 7348.52234604749, 7401.851962960711, 7437.293457121565, 7455.627218639046, 7631.130373058636, 957.5738796235747, 1090.738222826516, 1104.320842681745, 1110.4059328259343, 1167.8598568171874, 33781.49327760086, 34177.658223417944, 34868.82565587156, 35003.649963500546, 36339.27321453556, 1108.3682301088463, 1127.3292391027326, 1134.3808875213224, 1188.3464094747853, 1211.3882489343002, 17168.570785730455, 17311.82688173102, 17353.56616084608, 17556.5610859727, 17569.47291581229, 534707.0, 538136.0, 540423.0, 540553.0, 542549.0, 58055.70972145112, 58504.41495585075, 58595.0, 58596.0, 58637.0, 1323.6955500235, 1353.7563238617142, 1356.7015256643326, 1441.3730027438098, 1453.1716921354937, 30410.239744006576, 33972.66027339794, 34102.82948585241, 36216.63783362238, 36432.63567364292, 57282.71358643347, 57956.0, 58046.4195358041, 58097.4190258092, 58099.4190058094, 506599.0, 509734.0, 510516.0, 512599.0, 512767.0, 29455.26361840971, 29816.70183298139, 32269.67730322667, 32612.836935816118, 32685.182870427478, 46128.30807537823, 46483.767581161876, 46674.0, 46768.766156170364, 47829.0, 40152.0, 40215.0, 40221.0, 40224.1955160901, 41757.37363939604, 39348.803255983534, 39372.60627393689, 39618.60381396149, 40165.0, 41412.1717565653, 40320.596794031684, 40689.59310406858, 40822.79588602038, 41368.965775855846, 41588.16823663449, 33989.0, 36166.27667446689, 36722.8163859179, 36855.0, 37136.188015134736, 28134.364764095255, 28135.655471235532, 28253.654049946752, 30318.393632127674, 30869.536956945216], "value": 20952.688939208303, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.73419543101556, 417.3281017561725, 419.12612203555585, 433.55993666428583, 454.94085768850044, 15578.376864925403, 19119.426417207487, 20083.0, 20289.086991085398, 20373.796262037376, 20106.899465502687, 20403.897980510075, 20550.38348849537, 20569.4857628559, 20977.58044839102, 5728.283964504427, 5742.79900203493, 5952.107183922403, 5953.70231488426, 5957.523398128139, 5786.768529258825, 5921.230240068807, 5929.140274660172, 5933.821985340447, 5934.673592952386, 5688.687122208277, 5798.217240672498, 5860.794872179475, 5865.736041878125, 5866.560007999396, 5804.100364443518, 5852.180694702745, 5868.23712917318, 5871.706414679292, 5887.705614719268, 5067.214581739836, 5243.134882744343, 5245.134552798783, 5263.657862238981, 5346.572274218092, 24355.634665480033, 24732.381690457703, 24858.5028299433, 24980.3754906127, 25084.623730644056, 2268.8184945204343, 2384.1655420602824, 2469.9873052048574, 2582.728813474577, 2661.680598328213, 13995.580132595936, 14586.854131458656, 14738.189399583018, 15006.099634021994, 15376.154311512862, 1736.4616968739606, 1791.8711211936397, 1803.107461806401, 1809.5204770735766, 1853.369854249548, 90667.54666226692, 93165.0, 93662.53168734112, 94128.99999999932, 94526.99999999932, 9926.751831204134, 10811.675649730521, 11304.491297891615, 11493.770124597628, 11696.824547631792, 13830.23933683637, 14126.152430854181, 14153.787693184611, 14222.502212422516, 14656.534346565471, 8444.493330400195, 8581.828363432822, 8652.653893844301, 8751.91248087511, 8771.692990745294, 8557.786055348666, 8595.441296315845, 8769.210771030637, 8799.956000220085, 9009.369344145978, 6823.863522729517, 6907.447404207752, 6917.481188910751, 6924.619145947021, 7091.787246382617, 1839.0620783400561, 1857.7860301677902, 1875.6623807714743, 1890.5840715042668, 1915.339207973247, 976.4775844922932, 1024.9077583017565, 1036.533559898034, 1056.2025670618634, 1110.267223632415, 19969.20123195056, 20430.284940027028, 20682.896585517276, 21045.579088418144, 21295.36113916585, 1004.8392257238953, 1026.984595231072, 1029.3735897282277, 1039.870016247969, 1051.3008849115406, 11125.388103654377, 11908.642740717793, 11975.071812660937, 12018.939905300418, 12064.638060858188, 463144.0, 480591.0, 487485.0, 489606.0, 496466.0, 80600.0, 85848.0, 86104.13895861087, 86742.56628716816, 88346.0, 1046.3408052926607, 1048.6801525534786, 1068.732816795801, 1078.5146683992234, 1104.640991677724, 18148.546286342946, 18458.723119152954, 18633.53416164607, 18658.253669853053, 18792.0, 31067.0, 43050.78474607732, 44926.0, 45322.0, 46468.0, 58284.0, 59252.70373648104, 60202.0, 60382.39617603768, 60641.0, 8753.518556479456, 8898.822023559622, 8911.821763564822, 9172.724818255463, 9306.06939306064, 12801.42393592272, 14043.789343160066, 14124.50564230247, 14135.43458261658, 14436.133831970115, 12137.150399471951, 12220.327881966577, 12259.754804903674, 12293.815592765937, 12976.15654982423, 11474.77050459003, 11716.355600442057, 11908.0, 11911.3448760319, 12218.938905305416, 12075.637730868088, 12112.636620901387, 12227.205231659913, 12719.300438475973, 12794.168379055332, 8867.334949878656, 8871.689490867788, 8905.332100092648, 9037.77405564866, 9325.626974920928, 11129.888701112885, 11613.709657258636, 11781.76436471283, 11858.229215100991, 12043.578474753693], "value": 9682.859062832807, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.2563667232596, 1460.9050411723238, 1523.4058717100331, 1636.8936019158755, 1821.9271229150834, 7517.774466765992, 8305.169483051692, 8496.107908669586, 8589.098144694795, 8771.780705482366, 8421.368397370206, 8522.488650680963, 8527.0, 8549.487030778158, 8664.350173736964, 2439.121916110199, 2460.052879641333, 2466.580681284186, 2471.653968444419, 2471.789897858684, 2377.240841777081, 2486.502699460106, 2487.7263501014872, 2492.6011838105906, 2492.713337966139, 2413.4690368118986, 2425.648280999254, 2471.9752802472017, 2473.3816545863533, 2479.0827393864297, 2317.5480781247666, 2366.597678394677, 2371.5494056129364, 2374.8812559371963, 2411.6985376827897, 2396.5206958608346, 2414.1550457339968, 2419.3709635494724, 2420.165043060141, 2421.8546887186826, 8648.43785153963, 8711.172438618321, 8720.8691869622, 8745.693900713444, 8753.299736021103, 5350.9732451337495, 5502.752376143083, 5503.944960550383, 5505.03661859173, 5559.638623489501, 3383.0696558446625, 3411.9147021324416, 3479.391106556368, 3502.702270307027, 3686.907827304312, 1088.1403691084033, 1089.145021158387, 1092.0881064311309, 1106.1980064453207, 1119.6361182615683, 11592.942035289854, 11694.707632309175, 11800.291982480992, 11805.881941180563, 11812.40937953099, 4925.729084900293, 4951.158303088484, 5048.949510504922, 5078.619103567247, 5104.591632669451, 10428.061474467182, 10429.426381549089, 10441.68674939753, 10441.947790261, 10459.947700261602, 5659.151127330933, 5686.2039314496005, 5690.715464226772, 5694.544436445074, 5697.772089116472, 4263.275243208662, 4571.565701258375, 4637.281221410687, 5030.496950304941, 5080.669756465818, 4132.628063474302, 4159.646430053419, 4255.87232383029, 4289.206496798102, 4308.2460569400855, 1301.5899991502647, 1307.895368370528, 1378.9655258618413, 1379.8827099696437, 1390.7288078824733, 978.7960511665855, 987.6740675577042, 1001.7445551384351, 1003.227514813604, 1015.1168483419473, 5868.618539794899, 5998.640081595031, 6168.506519478431, 6211.3478084801345, 6232.0, 494.6809307996322, 507.4266079330333, 517.6376536424518, 519.721948757413, 993.2153598657125, 3978.8806335809973, 4056.918861622751, 4073.327900896378, 4107.178564287155, 4236.9364459533135, 10651.573937042587, 10778.946105269424, 10878.129749620011, 10881.075108615698, 10909.83635245472, 10578.735531611772, 10855.728606784736, 10874.293170943864, 10880.72798180036, 10911.672649820519, 8166.836663266701, 8392.706255281037, 8419.36854735885, 8443.240108390275, 8458.534780587126, 5992.610480318765, 6024.0, 6071.544634152545, 6078.848028799315, 6137.723802428812, 9628.085331893459, 9845.45849978258, 9899.554520046759, 9934.801303973736, 10043.849342259726, 8784.868226976729, 8956.776080598038, 9970.50147492637, 10095.141912937188, 10393.42836143989, 8052.758417247492, 8149.918500814916, 8187.26314631686, 8368.87446688288, 8420.789480263042, 8528.616212270586, 8599.054104048424, 8635.179657932485, 8643.87034194475, 8644.049154592863, 7541.396688265036, 7546.358559522502, 7550.697972081055, 7714.4599878008, 7741.535507869546, 7344.449166312441, 7513.699452021858, 7595.506292090997, 7624.809379765328, 7671.731489397845, 6991.930080699128, 7170.96414517924, 7171.8565628688175, 7173.10336207974, 7192.31672991065, 5180.948190518046, 5289.523942845162, 5345.786168553214, 5369.382521010134, 5510.972445137749, 5315.149576067811, 5318.7074710891275, 5320.893582128413, 5396.568274537949, 5406.756695948613], "value": 4661.231949193204, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.1830081008819, 350.57405252618065, 354.97058530262234, 368.1477379865611, 369.34441366574345, 5128.53843154116, 5236.842894713155, 5335.66608347913, 5363.356397232333, 5401.758944633218, 5075.492450754923, 5201.349831271091, 5218.877941242632, 5220.817271395502, 5228.372595288571, 4203.936940945889, 4215.135897141094, 4216.4940207175105, 4217.283061879472, 4230.619244268015, 4032.697547683935, 4137.731047481919, 4225.598568136023, 4227.154569086179, 4234.835420259423, 4060.979695101535, 4129.132882094764, 4136.565660605638, 4157.417961485395, 4157.625813676768, 4112.979435102835, 4115.773632450214, 4129.401236820644, 4133.772642504661, 4154.563770804082, 3536.717062634983, 3640.4175331946763, 3662.066173125836, 3665.4135338345736, 3678.172411207457, 5115.565176959963, 5129.794498292936, 5133.640645154841, 5141.897162056738, 5154.4587818278915, 4728.196206644879, 4743.786529606142, 4760.738159401231, 4766.904661906777, 4769.928451073237, 5413.83758487246, 5492.670439773627, 5516.310461192351, 5529.557635389159, 5537.861553461155, 4046.9392959105635, 4047.655949244318, 4059.7361171523758, 4062.0502158963864, 4069.7965101744794, 5675.5743319250805, 5677.772889084432, 5679.801206957736, 5716.628419152742, 5755.366909639978, 3972.708869617386, 4100.897477563025, 4116.0, 4119.217348703737, 4135.069609337875, 4149.481314835645, 4160.979195104005, 4166.708330416903, 4174.436451079066, 4178.958210417918, 4720.693154944917, 4724.267738500538, 4725.810967561328, 4734.313524538922, 4749.480166346736, 5315.867103322371, 5520.019189637551, 5536.252605898152, 5540.445955404508, 5555.8888822223325, 1346.8181795457683, 1378.5657517881834, 1379.165604809076, 1401.8948578856628, 1414.4017260495575, 941.7286663004888, 965.826520777259, 975.6389836178491, 978.9021097890296, 983.4443539400216, 5060.620453466005, 5083.771230294646, 5085.364329458817, 5120.48795120485, 5152.896942061137, 5399.163129714901, 5419.512243898068, 5428.511433970962, 5460.726963651801, 5478.780848766084, 4887.283771160847, 5118.411382690963, 5139.460356662496, 5151.278820965068, 5157.029087602525, 2884.9134525964255, 2903.8112522685956, 2903.867491678247, 2912.4466351393166, 2915.6792752797173, 5544.22380866679, 5560.666360018412, 5573.721313934287, 5607.15909601924, 5618.6628802272, 5264.42091369949, 5450.727463626803, 5473.318074143641, 5497.285352904097, 5535.667859928337, 5585.58108141891, 5588.552915766729, 5600.05996851648, 5612.663240205601, 5615.691136987505, 5139.794408223629, 5416.9729151353995, 5417.268668729671, 5447.509724124848, 5448.346198456211, 5377.064256867447, 5410.756515956713, 5426.782928682808, 5431.565474762088, 5432.728363581884, 5649.802256920988, 5651.802186923438, 5654.971725141512, 5663.423142470084, 5674.4892959633835, 3897.5517815451585, 4024.510930955565, 4036.3340048891605, 4036.6367026967714, 4051.716379853382, 5392.7573259202645, 5404.567634589302, 5412.702301373462, 5434.728263586726, 5449.918251226314, 5416.647917885325, 5437.265969094122, 5472.398036215934, 5523.8066667666435, 5527.088030474926, 5489.176623506506, 5503.651605356713, 5511.283533140666, 5526.005319042611, 5542.584306176972, 5278.516179321629, 5458.0, 5458.590605704509, 5473.233747275464, 5473.288472498709, 5523.2819733436, 5537.916931246115, 5544.223808666709, 5551.722413879371, 5557.805476808292, 5394.649347792381, 5407.486288802557, 5425.810096646598, 5427.348718153847, 5442.972785136049], "value": 4186.511302542977, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.3903459890533, 809.4374409785198, 852.3309202276214, 860.4536119564077, 865.7705707987388, 15035.0, 16019.279132439053, 16052.43816466424, 16058.518244452656, 16062.678746425065, 14815.481458148966, 14950.925245373784, 14960.251987400641, 14966.32651530681, 14973.625659358495, 712.5332906945958, 725.383424089525, 846.699421705295, 871.8517851965149, 887.0641473245723, 866.3891956170916, 880.1418616848554, 880.5905254056862, 881.1100788203928, 881.3037700216853, 926.115559640545, 927.4574373991223, 927.5918595817852, 928.6192661008988, 928.767808047988, 760.6006846405626, 763.6792547130219, 865.8008658008694, 922.4649703172178, 924.3437159616681, 624.4629618528062, 647.6276141218771, 647.757091090841, 647.9611223326616, 647.9902801457982, 14996.25018749069, 15023.248837558078, 15029.849701503064, 15039.774403383957, 15102.848971510253, 12561.309127997956, 12836.294003829786, 12953.158044727063, 13045.934770326088, 13117.934410327982, 11178.217524773268, 11204.439778011067, 11295.49170287339, 11354.60258890943, 11424.143189260838, 4137.565555616678, 4142.647874930634, 4171.770552619605, 4186.748795072305, 4195.727277726968, 65651.343486565, 67066.0, 67255.0, 69090.0, 69229.65385173092, 10307.278490505743, 10427.061564459234, 10427.530761115768, 10458.738531536772, 10501.9474902625, 21711.565768684854, 21734.89132554327, 21764.564708706053, 21955.67066494004, 22321.776782232293, 8101.675932962733, 8326.791830204173, 8363.623636936352, 8392.538410387488, 8428.157184281523, 4483.327500874895, 4506.526814684476, 4610.492845786961, 4636.281376386665, 4717.103750287434, 3444.3111377724554, 3522.63012383696, 3560.127768696686, 3562.109472631842, 3569.625189355132, 573.2919843992665, 573.4408951272476, 585.3970410477215, 595.9463648271676, 611.7461253579803, 653.7450394346209, 663.8473151175257, 697.9092717946736, 717.3221305866011, 724.641302555228, 8581.95709021451, 8638.453003645565, 8713.738587842376, 8896.688615898542, 9033.412828166149, 667.6227931218846, 683.9658017099125, 684.9178098628197, 690.7202582953811, 734.2583990169967, 4113.259613269581, 4182.623563879265, 4191.559886211904, 4220.134872351222, 4250.234957707642, 51619.741901291, 55627.0, 91413.54293228491, 96910.51544742231, 97968.0, 65988.0, 71927.6403617989, 72946.27053729501, 74513.25486745063, 76906.0, 48593.757031215326, 48789.02421951541, 61808.690956545826, 67722.3227767716, 68035.65982170157, 8332.50004999702, 8504.489730616182, 8601.311895048257, 9125.954370228106, 9654.75863103428, 44474.555254448336, 45266.54733452755, 45516.0, 45885.77057114693, 46172.0, 61603.69198153981, 64469.355306446334, 65592.67203663952, 66272.0, 68999.3100068993, 10951.178661600572, 11223.214374993671, 11345.659630211107, 11695.707607309885, 11773.117016223647, 12470.5011799527, 12630.494780208688, 12741.936290318488, 12781.936090319861, 12858.67853303675, 12151.81772273399, 12174.452149653463, 12441.63188100078, 12714.300713460849, 12752.234865908074, 12421.813672794735, 12685.682857928625, 12782.61652150437, 13065.738685226052, 13210.339483026002, 11878.643640690792, 11974.58088966882, 12290.078244131548, 12495.750084998432, 12591.118621696392, 9687.176589989647, 9749.610015599297, 9964.950175249078, 9995.118014526664, 10084.495775211064, 8854.955725221333, 9329.346945713734, 10003.29976901639, 10168.694939151837, 10235.7441063974], "value": 7049.153204840146, "unit": "score"}], "name": "dromaeo_css", "value": 7313.926129907473, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 120.0, 160.0, 121.0, 118.0, 119.0, 117.0, 147.0, 119.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 163.0, 161.0, 160.0, 161.0, 162.0, 160.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 101.0, 75.0, 74.0, 75.0, 75.0, 107.0, 75.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 114.0, 82.0, 83.0, 81.0, 108.0, 81.0, 81.0, 107.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 53.0, 53.0, 51.0, 53.0, 54.0, 53.0, 53.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 59.0, 59.0, 60.0, 60.0, 58.0, 59.0, 59.0, 58.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 83.0, 75.0, 76.0, 75.0, 82.0, 74.0, 75.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 131.0, 133.0, 129.0, 121.0, 119.0, 120.0, 125.0, 164.0, 126.0], "value": 129.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 153.0, 156.0, 158.0, 153.0, 156.0, 154.0, 156.0, 154.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 67.0, 66.0, 64.0, 62.0, 63.0, 63.0, 61.0, 59.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1452.3000000000002, "alertThreshold": 2.0}]} 18:38:31 INFO - Return code: 0 18:38:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:38:31 INFO - # TBPL SUCCESS # 18:38:31 INFO - Running post-action listener: _resource_record_post_action 18:38:31 INFO - [mozharness: 2017-01-03 02:38:31.469047Z] Finished run-tests step (success) 18:38:31 INFO - Running post-run listener: _resource_record_post_run 18:38:31 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 356974592; Read time: 144; Write time: 242412 18:38:31 INFO - TinderboxPrint: CPU usage
13.0% 18:38:31 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 144 18:38:31 INFO - TinderboxPrint: I/O write bytes / time
356,974,592 / 242,412 18:38:31 INFO - TinderboxPrint: CPU idle
8,263.0 (87.0%) 18:38:31 INFO - TinderboxPrint: CPU user
1,190.8 (12.5%) 18:38:31 INFO - TinderboxPrint: Swap in / out
0 / 0 18:38:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118710272; Read time: 0; Write time: 88264 18:38:31 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 237797376; Read time: 136; Write time: 154140 18:38:32 INFO - Running post-run listener: _upload_blobber_files 18:38:32 INFO - Blob upload gear active. 18:38:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:38:32 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 18:38:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:38:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:38:32 INFO - (blobuploader) - INFO - Open directory for files ... 18:38:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:38:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:38:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:33 INFO - (blobuploader) - INFO - Done attempting. 18:38:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:38:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:38:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:33 INFO - (blobuploader) - INFO - Done attempting. 18:38:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:38:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:38:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:37 INFO - (blobuploader) - INFO - Done attempting. 18:38:37 INFO - (blobuploader) - INFO - Iteration through files over. 18:38:37 INFO - Return code: 0 18:38:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:38:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:38:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a06ebbf15d51c151382a32a6a6e1ab43a7e700ff4d2c9dda7b783eb6077748b4a1ecaf3d0626af87e950993e1d09d8577074ca83129b59dd8a237e022de7f00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d5e898f93b4ea9ac2e4cd0807de29467544854a2bf017625d9fd1f9b8b9ac754bb5d3e58d76d7670f1ba79c523d63ea506ebaa43c210c49c22e8c538e4d4c16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4fe40c3268c0a677ce9a0cd612139612fa636efebd10b74e196a0498b58c46da7982eb0b8dd1ac9b8b7eb86df010168ce44d8b898e6db8b6ad93f9f778db6928"} 18:38:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:38:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:38:37 INFO - Contents: 18:38:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a06ebbf15d51c151382a32a6a6e1ab43a7e700ff4d2c9dda7b783eb6077748b4a1ecaf3d0626af87e950993e1d09d8577074ca83129b59dd8a237e022de7f00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d5e898f93b4ea9ac2e4cd0807de29467544854a2bf017625d9fd1f9b8b9ac754bb5d3e58d76d7670f1ba79c523d63ea506ebaa43c210c49c22e8c538e4d4c16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4fe40c3268c0a677ce9a0cd612139612fa636efebd10b74e196a0498b58c46da7982eb0b8dd1ac9b8b7eb86df010168ce44d8b898e6db8b6ad93f9f778db6928"} 18:38:37 INFO - Running post-run listener: copy_logs_to_upload_dir 18:38:37 INFO - Copying logs to upload dir... 18:38:37 INFO - mkdir: /builds/slave/test/build/upload/logs 18:38:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.812671 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-01-02 18:38:36.027137) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-02 18:38:36.030413) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a06ebbf15d51c151382a32a6a6e1ab43a7e700ff4d2c9dda7b783eb6077748b4a1ecaf3d0626af87e950993e1d09d8577074ca83129b59dd8a237e022de7f00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d5e898f93b4ea9ac2e4cd0807de29467544854a2bf017625d9fd1f9b8b9ac754bb5d3e58d76d7670f1ba79c523d63ea506ebaa43c210c49c22e8c538e4d4c16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4fe40c3268c0a677ce9a0cd612139612fa636efebd10b74e196a0498b58c46da7982eb0b8dd1ac9b8b7eb86df010168ce44d8b898e6db8b6ad93f9f778db6928"} build_url:https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011235 build_url: 'https://queue.taskcluster.net/v1/task/I_M3q86fQs-vL9cbypiGgg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a06ebbf15d51c151382a32a6a6e1ab43a7e700ff4d2c9dda7b783eb6077748b4a1ecaf3d0626af87e950993e1d09d8577074ca83129b59dd8a237e022de7f00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d5e898f93b4ea9ac2e4cd0807de29467544854a2bf017625d9fd1f9b8b9ac754bb5d3e58d76d7670f1ba79c523d63ea506ebaa43c210c49c22e8c538e4d4c16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4fe40c3268c0a677ce9a0cd612139612fa636efebd10b74e196a0498b58c46da7982eb0b8dd1ac9b8b7eb86df010168ce44d8b898e6db8b6ad93f9f778db6928"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-02 18:38:36.055704) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 18:38:36.056051) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1483407458.713413-1094403602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 18:38:36.140973) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-02 18:38:36.141904) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-02 18:38:36.142226) ========= ========= Total master_lag: 0.20 =========