builder: larch_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1476279358.73 results: success (0) buildid: 20161012051247 builduid: 8eefdbdd4b2043f0ad22a091a8ccd2a3 revision: 4756eb1a2f82a6fb2e7ab5e3708d14aa76816076 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:58.729644) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:58.730088) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:58.730386) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:58.782428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:58.782846) ========= 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=4300f881736b422476174874000001bc-1476274921.318071-923543322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-12 06:35:59-- 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% 24.4M=0s 2016-10-12 06:35:59 (24.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.368322 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:59.166105) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:59.166499) ========= 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=4300f881736b422476174874000001bc-1476274921.318071-923543322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017665 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:59.216132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:59.216564) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 4756eb1a2f82a6fb2e7ab5e3708d14aa76816076 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 4756eb1a2f82a6fb2e7ab5e3708d14aa76816076 --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=4300f881736b422476174874000001bc-1476274921.318071-923543322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-12 06:35:59,630 truncating revision to first 12 chars 2016-10-12 06:35:59,630 Setting DEBUG logging. 2016-10-12 06:35:59,630 attempt 1/10 2016-10-12 06:35:59,630 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/4756eb1a2f82?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 06:35:59,923 unpacking tar archive at: larch-4756eb1a2f82/testing/mozharness/ program finished with exit code 0 elapsedTime=0.624167 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:59.854377) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:59.854704) ========= script_repo_revision: 4756eb1a2f82a6fb2e7ab5e3708d14aa76816076 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:59.855110) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:59.855392) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:59.864982) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-12 06:35:59.865396) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1476274921.318071-923543322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:36:00 INFO - MultiFileLogger online at 20161012 06:36:00 in /builds/slave/test 06:36:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 06:36:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:36:00 INFO - {'append_to_log': False, 06:36:00 INFO - 'base_work_dir': '/builds/slave/test', 06:36:00 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 06:36:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:36:00 INFO - 'branch': 'Larch-Non-PGO', 06:36:00 INFO - 'buildbot_json_path': 'buildprops.json', 06:36:00 INFO - 'config_files': ('talos/linux_config.py',), 06:36:00 INFO - 'default_actions': ('clobber', 06:36:00 INFO - 'read-buildbot-config', 06:36:00 INFO - 'download-and-extract', 06:36:00 INFO - 'populate-webroot', 06:36:00 INFO - 'create-virtualenv', 06:36:00 INFO - 'install', 06:36:00 INFO - 'run-tests'), 06:36:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:36:00 INFO - 'download_minidump_stackwalk': True, 06:36:00 INFO - 'download_symbols': 'ondemand', 06:36:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:36:00 INFO - 'tooltool.py': '/tools/tooltool.py', 06:36:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:36:00 INFO - '/tools/misc-python/virtualenv.py')}, 06:36:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:36:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:36:00 INFO - 'installer_path': 'installer.exe', 06:36:00 INFO - 'log_level': 'info', 06:36:00 INFO - 'log_name': 'talos', 06:36:00 INFO - 'log_to_console': True, 06:36:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:36:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:36:00 INFO - 'opt_config_files': (), 06:36:00 INFO - 'pip_index': False, 06:36:00 INFO - 'sps_profile': False, 06:36:00 INFO - 'sps_profile_interval': 0, 06:36:00 INFO - 'suite': 'dromaeojs', 06:36:00 INFO - 'system_bits': '32', 06:36:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:36:00 INFO - 'title': 'talos-linux64-ix-045', 06:36:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:36:00 INFO - 'use_talos_json': True, 06:36:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:36:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:36:00 INFO - 'work_dir': 'build'} 06:36:00 INFO - [mozharness: 2016-10-12 13:36:00.377852Z] Running clobber step. 06:36:00 INFO - Running pre-action listener: _resource_record_pre_action 06:36:00 INFO - Running main action method: clobber 06:36:00 INFO - rmtree: /builds/slave/test/build 06:36:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:36:00 INFO - Running post-action listener: _resource_record_post_action 06:36:00 INFO - [mozharness: 2016-10-12 13:36:00.836771Z] Finished clobber step (success) 06:36:00 INFO - [mozharness: 2016-10-12 13:36:00.836871Z] Running read-buildbot-config step. 06:36:00 INFO - Running pre-action listener: _resource_record_pre_action 06:36:00 INFO - Running main action method: read_buildbot_config 06:36:00 INFO - Using buildbot properties: 06:36:00 INFO - { 06:36:00 INFO - "project": "", 06:36:00 INFO - "product": "firefox", 06:36:00 INFO - "script_repo_revision": "production", 06:36:00 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs", 06:36:00 INFO - "repository": "", 06:36:00 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs", 06:36:00 INFO - "buildid": "20161012051247", 06:36:00 INFO - "pgo_build": "False", 06:36:00 INFO - "basedir": "/builds/slave/test", 06:36:00 INFO - "buildnumber": 3, 06:36:00 INFO - "slavename": "talos-linux64-ix-045", 06:36:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:36:00 INFO - "platform": "ubuntu64_hw", 06:36:00 INFO - "scheduler": "tests-larch-linux64-talos", 06:36:00 INFO - "branch": "larch", 06:36:00 INFO - "repo_path": "projects/larch", 06:36:00 INFO - "revision": "4756eb1a2f82a6fb2e7ab5e3708d14aa76816076", 06:36:00 INFO - "stage_platform": "linux64", 06:36:00 INFO - "builduid": "8eefdbdd4b2043f0ad22a091a8ccd2a3", 06:36:00 INFO - "slavebuilddir": "test" 06:36:00 INFO - } 06:36:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:36:00 INFO - Running post-action listener: _resource_record_post_action 06:36:00 INFO - [mozharness: 2016-10-12 13:36:00.839296Z] Finished read-buildbot-config step (success) 06:36:00 INFO - [mozharness: 2016-10-12 13:36:00.839383Z] Running download-and-extract step. 06:36:00 INFO - Running pre-action listener: _resource_record_pre_action 06:36:00 INFO - Running main action method: download_and_extract 06:36:00 INFO - mkdir: /builds/slave/test/build/tests 06:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:00 INFO - trying https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:36:00 INFO - Downloading https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:36:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:36:01 INFO - Downloaded 1361 bytes. 06:36:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:36:01 INFO - Using the following test package requirements: 06:36:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:36:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:36:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:36:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:01 INFO - u'jsshell-linux-x86_64.zip'], 06:36:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:36:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:36:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:36:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:36:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:36:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:36:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:36:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:36:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:36:01 INFO - Fetch https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:36:02 INFO - Http code: 200 06:36:02 INFO - via: 1.1 b04a4cffa8fb4f524ff7edcab1b5ae31.cloudfront.net (CloudFront) 06:36:02 INFO - x-amz-cf-id: PbbaC8U01cYlCDr1BkySxd5iWkUdbB7bm9fAGkZQ47lLJ0posWKARQ== 06:36:02 INFO - x-amz-version-id: mvkBAAMF2Pa_wBNlJuBi40QSPJQeBfnz 06:36:02 INFO - Expected file size: 20528584 06:36:02 INFO - Obtained file size: 20528584 06:36:06 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:36:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:36:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:36:06 INFO - Fetch https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:36:06 INFO - Http code: 200 06:36:06 INFO - via: 1.1 2a47832c458ab2a6b20c8363f5aa35ea.cloudfront.net (CloudFront) 06:36:06 INFO - x-amz-cf-id: EkrirYk4BMOWk-_iAffARCEhPxuF_f1FBZs3So1_0J356zZ7g_Nwwg== 06:36:06 INFO - x-amz-version-id: mvkBAAMF2Pa_wBNlJuBi40QSPJQeBfnz 06:36:07 INFO - Expected file size: 20528584 06:36:07 INFO - Obtained file size: 20528584 06:36:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:36:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:36:11 INFO - Fetch https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:36:12 INFO - Http code: 200 06:36:12 INFO - via: 1.1 30bb04916f91d64c600e15c15000042d.cloudfront.net (CloudFront) 06:36:12 INFO - x-amz-cf-id: cdnRGsv9hRhYay3AHzFwVXmlAdzZyufL6_0QbfrHX1p_2roiOes9_w== 06:36:12 INFO - x-amz-version-id: VwLmDL9HMrV_jQjvgp1awave.RHqZB42 06:36:12 INFO - Expected file size: 14409006 06:36:12 INFO - Obtained file size: 14409006 06:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:12 INFO - trying https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:36:12 INFO - Downloading https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:36:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:36:14 INFO - Downloaded 56011968 bytes. 06:36:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:36:14 INFO - mkdir: /builds/slave/test/properties 06:36:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:36:14 INFO - Writing to file /builds/slave/test/properties/build_url 06:36:14 INFO - Contents: 06:36:14 INFO - build_url:https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:36:14 INFO - Running post-action listener: _resource_record_post_action 06:36:14 INFO - Running post-action listener: set_extra_try_arguments 06:36:14 INFO - [mozharness: 2016-10-12 13:36:14.794213Z] Finished download-and-extract step (success) 06:36:14 INFO - [mozharness: 2016-10-12 13:36:14.794438Z] Running populate-webroot step. 06:36:14 INFO - Running pre-action listener: _resource_record_pre_action 06:36:14 INFO - Running main action method: populate_webroot 06:36:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:36:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:36:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:36:14 INFO - '--tppagecycles', 06:36:14 INFO - '7'], 06:36:14 INFO - 'tests': ['tsvgm']}}, 06:36:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:36:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:36:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:36:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:36:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:14 INFO - 'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:36:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:36:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:14 INFO - 'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['damp', 'tps']}, 06:36:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:14 INFO - 'tests': ['damp', 'tps']}, 06:36:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['dromaeo_dom']}, 06:36:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:36:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['basic_compositor_video']}, 06:36:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:36:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['a11yr', 06:36:14 INFO - 'ts_paint', 06:36:14 INFO - 'tpaint', 06:36:14 INFO - 'sessionrestore', 06:36:14 INFO - 'sessionrestore_no_auto_restore', 06:36:14 INFO - 'tabpaint']}, 06:36:14 INFO - 'other-e10s': {'tests': ['a11yr', 06:36:14 INFO - 'ts_paint', 06:36:14 INFO - 'tpaint', 06:36:14 INFO - 'sessionrestore', 06:36:14 INFO - 'sessionrestore_no_auto_restore', 06:36:14 INFO - 'tabpaint']}, 06:36:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:36:14 INFO - 'ts_paint', 06:36:14 INFO - 'tpaint', 06:36:14 INFO - 'sessionrestore', 06:36:14 INFO - 'sessionrestore_no_auto_restore', 06:36:14 INFO - 'tabpaint']}, 06:36:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:36:14 INFO - 'ts_paint', 06:36:14 INFO - 'tpaint', 06:36:14 INFO - 'sessionrestore', 06:36:14 INFO - 'sessionrestore_no_auto_restore', 06:36:14 INFO - 'tabpaint']}, 06:36:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['a11yr', 06:36:14 INFO - 'ts_paint', 06:36:14 INFO - 'tpaint', 06:36:14 INFO - 'sessionrestore', 06:36:14 INFO - 'sessionrestore_no_auto_restore', 06:36:14 INFO - 'tabpaint']}, 06:36:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['a11yr', 06:36:14 INFO - 'ts_paint', 06:36:14 INFO - 'tpaint', 06:36:14 INFO - 'sessionrestore', 06:36:14 INFO - 'sessionrestore_no_auto_restore', 06:36:14 INFO - 'tabpaint']}, 06:36:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['tsvgx', 06:36:14 INFO - 'tsvgr_opacity', 06:36:14 INFO - 'tart', 06:36:14 INFO - 'tscrollx', 06:36:14 INFO - 'cart']}, 06:36:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:36:14 INFO - 'tsvgr_opacity', 06:36:14 INFO - 'tart', 06:36:14 INFO - 'tscrollx', 06:36:14 INFO - 'cart']}, 06:36:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:14 INFO - 'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['tp5o']}, 06:36:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:14 INFO - 'tests': ['tp5o']}, 06:36:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:14 INFO - 'talos_options': ['--disable-e10s', 06:36:14 INFO - '--xperf_path', 06:36:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:36:14 INFO - 'tests': ['tp5n']}, 06:36:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:14 INFO - 'talos_options': ['--xperf_path', 06:36:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:36:14 INFO - 'tests': ['tp5n']}}, 06:36:14 INFO - 'talos.zip': {'path': '', 06:36:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:36:14 INFO - Running post-action listener: _resource_record_post_action 06:36:14 INFO - [mozharness: 2016-10-12 13:36:14.809600Z] Finished populate-webroot step (success) 06:36:14 INFO - [mozharness: 2016-10-12 13:36:14.809688Z] Running create-virtualenv step. 06:36:14 INFO - Running pre-action listener: _resource_record_pre_action 06:36:14 INFO - Running main action method: create_virtualenv 06:36:14 INFO - Creating virtualenv /builds/slave/test/build/venv 06:36:14 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 06:36:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:36:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:36:14 INFO - Using real prefix '/usr' 06:36:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:36:15 INFO - Installing distribute.............................................................................................................................................................................................done. 06:36:17 INFO - Installing pip.................done. 06:36:17 INFO - Return code: 0 06:36:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:36:17 INFO - Reading from file tmpfile_stdout 06:36:17 INFO - Output received: 06:36:17 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) 06:36:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:36:17 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')]} 06:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:17 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')]} 06:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:17 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 0x7fb93fd1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2109ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106f60>, '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 0x2107d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21081d0>, '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': '4300f881736b422476174874000001bc-1476274921.318071-923543322', '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 06:36:17 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 06:36:17 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 06:36:17 INFO - Using env: {'DISPLAY': ':0', 06:36:17 INFO - 'HOME': '/home/cltbld', 06:36:17 INFO - 'LANG': 'en_US.UTF-8', 06:36:17 INFO - 'LANGUAGE': 'en_US:en', 06:36:17 INFO - 'LOGNAME': 'cltbld', 06:36:17 INFO - 'MAIL': '/var/mail/cltbld', 06:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:17 INFO - 'MOZ_NO_REMOTE': '1', 06:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:17 INFO - 'NO_EM_RESTART': '1', 06:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:17 INFO - 'PWD': '/builds/slave/test', 06:36:17 INFO - 'SHELL': '/bin/bash', 06:36:17 INFO - 'SHLVL': '1', 06:36:17 INFO - 'TERM': 'linux', 06:36:17 INFO - 'TMOUT': '86400', 06:36:17 INFO - 'USER': 'cltbld', 06:36:17 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1476274921.318071-923543322', 06:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:17 INFO - '_': '/tools/buildbot/bin/python'} 06:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:17 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 06:36:17 INFO - Cleaning up... 06:36:17 INFO - Return code: 0 06:36:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:36:17 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')]} 06:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:17 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')]} 06:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:17 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 0x7fb93fd1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2109ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106f60>, '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 0x2107d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21081d0>, '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': '4300f881736b422476174874000001bc-1476274921.318071-923543322', '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 06:36:17 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 06:36:17 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 06:36:17 INFO - Using env: {'DISPLAY': ':0', 06:36:17 INFO - 'HOME': '/home/cltbld', 06:36:17 INFO - 'LANG': 'en_US.UTF-8', 06:36:17 INFO - 'LANGUAGE': 'en_US:en', 06:36:17 INFO - 'LOGNAME': 'cltbld', 06:36:17 INFO - 'MAIL': '/var/mail/cltbld', 06:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:17 INFO - 'MOZ_NO_REMOTE': '1', 06:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:17 INFO - 'NO_EM_RESTART': '1', 06:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:17 INFO - 'PWD': '/builds/slave/test', 06:36:17 INFO - 'SHELL': '/bin/bash', 06:36:17 INFO - 'SHLVL': '1', 06:36:17 INFO - 'TERM': 'linux', 06:36:17 INFO - 'TMOUT': '86400', 06:36:17 INFO - 'USER': 'cltbld', 06:36:17 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1476274921.318071-923543322', 06:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:17 INFO - '_': '/tools/buildbot/bin/python'} 06:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:18 INFO - Downloading/unpacking psutil>=3.1.1 06:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:36:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:36:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:36:20 INFO - Installing collected packages: psutil 06:36:20 INFO - Running setup.py install for psutil 06:36:20 INFO - building 'psutil._psutil_linux' extension 06:36:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:36:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:36:20 INFO - building 'psutil._psutil_posix' extension 06:36:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:36:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:36:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:36:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:36:20 INFO - Successfully installed psutil 06:36:20 INFO - Cleaning up... 06:36:20 INFO - Return code: 0 06:36:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:36: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')]} 06:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36: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')]} 06:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb93fd1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2109ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106f60>, '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 0x2107d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21081d0>, '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': '4300f881736b422476174874000001bc-1476274921.318071-923543322', '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 06:36: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:36: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 mozsystemmonitor==0.3 06:36:20 INFO - Using env: {'DISPLAY': ':0', 06:36:20 INFO - 'HOME': '/home/cltbld', 06:36:20 INFO - 'LANG': 'en_US.UTF-8', 06:36:20 INFO - 'LANGUAGE': 'en_US:en', 06:36:20 INFO - 'LOGNAME': 'cltbld', 06:36:20 INFO - 'MAIL': '/var/mail/cltbld', 06:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:20 INFO - 'MOZ_NO_REMOTE': '1', 06:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:20 INFO - 'NO_EM_RESTART': '1', 06:36:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:20 INFO - 'PWD': '/builds/slave/test', 06:36:20 INFO - 'SHELL': '/bin/bash', 06:36:20 INFO - 'SHLVL': '1', 06:36:20 INFO - 'TERM': 'linux', 06:36:20 INFO - 'TMOUT': '86400', 06:36:20 INFO - 'USER': 'cltbld', 06:36:20 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1476274921.318071-923543322', 06:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:20 INFO - '_': '/tools/buildbot/bin/python'} 06:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:36:20 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 06:36:20 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 06:36:20 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 06:36:20 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 06:36:20 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 06:36:20 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 06:36:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:36:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:36:22 INFO - Installing collected packages: mozsystemmonitor 06:36:22 INFO - Running setup.py install for mozsystemmonitor 06:36:22 INFO - Successfully installed mozsystemmonitor 06:36:22 INFO - Cleaning up... 06:36:22 INFO - Return code: 0 06:36:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:22 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 0x7fb93fd1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2109ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106f60>, '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 0x2107d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21081d0>, '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': '4300f881736b422476174874000001bc-1476274921.318071-923543322', '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 06:36:22 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 06:36:22 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 06:36:22 INFO - Using env: {'DISPLAY': ':0', 06:36:22 INFO - 'HOME': '/home/cltbld', 06:36:22 INFO - 'LANG': 'en_US.UTF-8', 06:36:22 INFO - 'LANGUAGE': 'en_US:en', 06:36:22 INFO - 'LOGNAME': 'cltbld', 06:36:22 INFO - 'MAIL': '/var/mail/cltbld', 06:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:22 INFO - 'MOZ_NO_REMOTE': '1', 06:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:22 INFO - 'NO_EM_RESTART': '1', 06:36:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:22 INFO - 'PWD': '/builds/slave/test', 06:36:22 INFO - 'SHELL': '/bin/bash', 06:36:22 INFO - 'SHLVL': '1', 06:36:22 INFO - 'TERM': 'linux', 06:36:22 INFO - 'TMOUT': '86400', 06:36:22 INFO - 'USER': 'cltbld', 06:36:23 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1476274921.318071-923543322', 06:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:23 INFO - '_': '/tools/buildbot/bin/python'} 06:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:23 INFO - Downloading/unpacking jsonschema==2.5.1 06:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:36:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:25 INFO - Downloading functools32-3.2.3-2.tar.gz 06:36:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:36:25 INFO - warning: no files found matching '*.txt' 06:36:25 INFO - no previously-included directories found matching 'build' 06:36:25 INFO - no previously-included directories found matching 'dist' 06:36:25 INFO - no previously-included directories found matching '.git*' 06:36:25 INFO - Installing collected packages: jsonschema, functools32 06:36:25 INFO - Running setup.py install for functools32 06:36:25 INFO - warning: no files found matching '*.txt' 06:36:25 INFO - no previously-included directories found matching 'build' 06:36:25 INFO - no previously-included directories found matching 'dist' 06:36:25 INFO - no previously-included directories found matching '.git*' 06:36:25 INFO - Successfully installed jsonschema functools32 06:36:25 INFO - Cleaning up... 06:36:25 INFO - Return code: 0 06:36:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:25 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 0x7fb93fd1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2109ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106f60>, '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 0x2107d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21081d0>, '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': '4300f881736b422476174874000001bc-1476274921.318071-923543322', '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 06:36:25 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 06:36:25 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 06:36:25 INFO - Using env: {'DISPLAY': ':0', 06:36:25 INFO - 'HOME': '/home/cltbld', 06:36:25 INFO - 'LANG': 'en_US.UTF-8', 06:36:25 INFO - 'LANGUAGE': 'en_US:en', 06:36:25 INFO - 'LOGNAME': 'cltbld', 06:36:25 INFO - 'MAIL': '/var/mail/cltbld', 06:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:25 INFO - 'MOZ_NO_REMOTE': '1', 06:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:25 INFO - 'NO_EM_RESTART': '1', 06:36:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:25 INFO - 'PWD': '/builds/slave/test', 06:36:25 INFO - 'SHELL': '/bin/bash', 06:36:25 INFO - 'SHLVL': '1', 06:36:25 INFO - 'TERM': 'linux', 06:36:25 INFO - 'TMOUT': '86400', 06:36:25 INFO - 'USER': 'cltbld', 06:36:25 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1476274921.318071-923543322', 06:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:25 INFO - '_': '/tools/buildbot/bin/python'} 06:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:36:25 INFO - Cleaning up... 06:36:25 INFO - Return code: 0 06:36:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:25 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 0x7fb93fd1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2109ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106f60>, '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 0x2107d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21081d0>, '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': '4300f881736b422476174874000001bc-1476274921.318071-923543322', '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 06:36:25 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 06:36:25 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 06:36:25 INFO - Using env: {'DISPLAY': ':0', 06:36:25 INFO - 'HOME': '/home/cltbld', 06:36:25 INFO - 'LANG': 'en_US.UTF-8', 06:36:25 INFO - 'LANGUAGE': 'en_US:en', 06:36:25 INFO - 'LOGNAME': 'cltbld', 06:36:25 INFO - 'MAIL': '/var/mail/cltbld', 06:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:25 INFO - 'MOZ_NO_REMOTE': '1', 06:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:25 INFO - 'NO_EM_RESTART': '1', 06:36:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:25 INFO - 'PWD': '/builds/slave/test', 06:36:25 INFO - 'SHELL': '/bin/bash', 06:36:25 INFO - 'SHLVL': '1', 06:36:25 INFO - 'TERM': 'linux', 06:36:25 INFO - 'TMOUT': '86400', 06:36:25 INFO - 'USER': 'cltbld', 06:36:25 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1476274921.318071-923543322', 06:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:25 INFO - '_': '/tools/buildbot/bin/python'} 06:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:26 INFO - Downloading/unpacking blobuploader==1.2.4 06:36: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 06:36: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 06:36: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 06:36: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 06:36: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 06:36: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 06:36:27 INFO - Downloading blobuploader-1.2.4.tar.gz 06:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:36:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:36: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 06:36: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 06:36: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 06:36: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 06:36: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 06:36: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 06:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:36:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:36: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 06:36: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 06:36: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 06:36: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 06:36: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 06:36: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 06:36:28 INFO - Downloading docopt-0.6.1.tar.gz 06:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:36:28 INFO - Installing collected packages: blobuploader, requests, docopt 06:36:28 INFO - Running setup.py install for blobuploader 06:36:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:36:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:36:28 INFO - Running setup.py install for requests 06:36:29 INFO - Running setup.py install for docopt 06:36:29 INFO - Successfully installed blobuploader requests docopt 06:36:29 INFO - Cleaning up... 06:36:29 INFO - Return code: 0 06:36:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36: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')]} 06:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36: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')]} 06:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:29 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 0x7fb93fd1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2109ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106f60>, '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 0x2107d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21081d0>, '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': '4300f881736b422476174874000001bc-1476274921.318071-923543322', '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 06:36:29 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 06:36:29 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 06:36:29 INFO - Using env: {'DISPLAY': ':0', 06:36:29 INFO - 'HOME': '/home/cltbld', 06:36:29 INFO - 'LANG': 'en_US.UTF-8', 06:36:29 INFO - 'LANGUAGE': 'en_US:en', 06:36:29 INFO - 'LOGNAME': 'cltbld', 06:36:29 INFO - 'MAIL': '/var/mail/cltbld', 06:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:29 INFO - 'MOZ_NO_REMOTE': '1', 06:36:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:29 INFO - 'NO_EM_RESTART': '1', 06:36:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:29 INFO - 'PWD': '/builds/slave/test', 06:36:29 INFO - 'SHELL': '/bin/bash', 06:36:29 INFO - 'SHLVL': '1', 06:36:29 INFO - 'TERM': 'linux', 06:36:29 INFO - 'TMOUT': '86400', 06:36:29 INFO - 'USER': 'cltbld', 06:36:29 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1476274921.318071-923543322', 06:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:29 INFO - '_': '/tools/buildbot/bin/python'} 06:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:36:29 INFO - Running setup.py (path:/tmp/pip-UU5Far-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:36:29 INFO - Running setup.py (path:/tmp/pip-z5wrpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:36:29 INFO - Running setup.py (path:/tmp/pip-gPXqyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:36:29 INFO - Running setup.py (path:/tmp/pip-nNeSqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:36:29 INFO - Running setup.py (path:/tmp/pip-6pML74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:36:29 INFO - Running setup.py (path:/tmp/pip-wzdTkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:36:29 INFO - Running setup.py (path:/tmp/pip-w6Nlgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:36:30 INFO - Running setup.py (path:/tmp/pip-8NhkTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:36:30 INFO - Running setup.py (path:/tmp/pip-ZjWgwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:36:30 INFO - Running setup.py (path:/tmp/pip-FyT68S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:36:30 INFO - Running setup.py (path:/tmp/pip-XPoP4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:36:30 INFO - Running setup.py (path:/tmp/pip-hs2QiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:36:30 INFO - Running setup.py (path:/tmp/pip-RDR7Tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:36:30 INFO - Running setup.py (path:/tmp/pip-wtJXap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:30 INFO - Running setup.py (path:/tmp/pip-RFkoAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:36:30 INFO - Running setup.py (path:/tmp/pip-XGTFeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:36:30 INFO - Running setup.py (path:/tmp/pip-LJi0sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:36:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:36:30 INFO - Running setup.py install for manifestparser 06:36:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:36:30 INFO - Running setup.py install for mozcrash 06:36:30 INFO - Running setup.py install for mozdebug 06:36:31 INFO - Running setup.py install for mozdevice 06:36:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Running setup.py install for mozfile 06:36:31 INFO - Running setup.py install for mozhttpd 06:36:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Running setup.py install for mozinfo 06:36:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Running setup.py install for mozInstall 06:36:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Running setup.py install for mozleak 06:36:31 INFO - Running setup.py install for mozlog 06:36:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Running setup.py install for moznetwork 06:36:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Running setup.py install for mozprocess 06:36:32 INFO - Running setup.py install for mozprofile 06:36:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:36:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:36:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:36:32 INFO - Running setup.py install for mozrunner 06:36:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:36:32 INFO - Running setup.py install for mozscreenshot 06:36:32 INFO - Running setup.py install for moztest 06:36:32 INFO - Running setup.py install for mozversion 06:36:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:36:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:36:32 INFO - Cleaning up... 06:36:32 INFO - Return code: 0 06:36:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36: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')]} 06:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36: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')]} 06:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:32 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 0x7fb93fd1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2109ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106f60>, '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 0x2107d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21081d0>, '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': '4300f881736b422476174874000001bc-1476274921.318071-923543322', '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 06:36:32 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 06:36:32 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 06:36:32 INFO - Using env: {'DISPLAY': ':0', 06:36:32 INFO - 'HOME': '/home/cltbld', 06:36:32 INFO - 'LANG': 'en_US.UTF-8', 06:36:32 INFO - 'LANGUAGE': 'en_US:en', 06:36:32 INFO - 'LOGNAME': 'cltbld', 06:36:32 INFO - 'MAIL': '/var/mail/cltbld', 06:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:32 INFO - 'MOZ_NO_REMOTE': '1', 06:36:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:32 INFO - 'NO_EM_RESTART': '1', 06:36:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:32 INFO - 'PWD': '/builds/slave/test', 06:36:32 INFO - 'SHELL': '/bin/bash', 06:36:32 INFO - 'SHLVL': '1', 06:36:32 INFO - 'TERM': 'linux', 06:36:32 INFO - 'TMOUT': '86400', 06:36:32 INFO - 'USER': 'cltbld', 06:36:32 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1476274921.318071-923543322', 06:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:32 INFO - '_': '/tools/buildbot/bin/python'} 06:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:36:32 INFO - Running setup.py (path:/tmp/pip-J_r452-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:36:32 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)) 06:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:36:32 INFO - Running setup.py (path:/tmp/pip-hnEjlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:36:32 INFO - Running setup.py (path:/tmp/pip-z2uMEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:36:33 INFO - Running setup.py (path:/tmp/pip-Fto2Kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:36:33 INFO - Running setup.py (path:/tmp/pip-xceUk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:36:33 INFO - Running setup.py (path:/tmp/pip-8QXhId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:36:33 INFO - Running setup.py (path:/tmp/pip-qmIin9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:36:33 INFO - Running setup.py (path:/tmp/pip-CIslJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:36:33 INFO - Running setup.py (path:/tmp/pip-sgpfBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:36:33 INFO - Running setup.py (path:/tmp/pip-bfQtFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:36:33 INFO - Running setup.py (path:/tmp/pip-KBu7Aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:36:33 INFO - Running setup.py (path:/tmp/pip-aam1vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:36:33 INFO - Running setup.py (path:/tmp/pip-HPRukO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:36:33 INFO - Running setup.py (path:/tmp/pip-0Zkqyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:33 INFO - Running setup.py (path:/tmp/pip-mwZ0e_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:36:33 INFO - Running setup.py (path:/tmp/pip-lYy0iP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:36:33 INFO - Running setup.py (path:/tmp/pip-_Zdegg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:36:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:35 INFO - Downloading blessings-1.6.tar.gz 06:36:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:36:36 INFO - Installing collected packages: blessings 06:36:36 INFO - Running setup.py install for blessings 06:36:36 INFO - Successfully installed blessings 06:36:36 INFO - Cleaning up... 06:36:36 INFO - Return code: 0 06:36:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:36:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:36:36 INFO - Reading from file tmpfile_stdout 06:36:36 INFO - Current package versions: 06:36:36 INFO - argparse == 1.2.1 06:36:36 INFO - blessings == 1.6 06:36:36 INFO - blobuploader == 1.2.4 06:36:36 INFO - docopt == 0.6.1 06:36:36 INFO - functools32 == 3.2.3-2 06:36:36 INFO - jsonschema == 2.5.1 06:36:36 INFO - manifestparser == 1.1 06:36:36 INFO - mozInstall == 1.12 06:36:36 INFO - mozcrash == 0.17 06:36:36 INFO - mozdebug == 0.1 06:36:36 INFO - mozdevice == 0.48 06:36:36 INFO - mozfile == 1.2 06:36:36 INFO - mozhttpd == 0.7 06:36:36 INFO - mozinfo == 0.9 06:36:36 INFO - mozleak == 0.1 06:36:36 INFO - mozlog == 3.4 06:36:36 INFO - moznetwork == 0.27 06:36:36 INFO - mozprocess == 0.23 06:36:36 INFO - mozprofile == 0.28 06:36:36 INFO - mozrunner == 6.12 06:36:36 INFO - mozscreenshot == 0.1 06:36:36 INFO - mozsystemmonitor == 0.3 06:36:36 INFO - moztest == 0.7 06:36:36 INFO - mozversion == 1.4 06:36:36 INFO - psutil == 3.1.1 06:36:36 INFO - requests == 1.2.3 06:36:36 INFO - wsgiref == 0.1.2 06:36:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36: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')]} 06:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36: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')]} 06:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:36 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 0x7fb93fd1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2109ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106f60>, '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 0x2107d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21081d0>, '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': '4300f881736b422476174874000001bc-1476274921.318071-923543322', '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 06:36:36 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 06:36:36 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 06:36:36 INFO - Using env: {'DISPLAY': ':0', 06:36:36 INFO - 'HOME': '/home/cltbld', 06:36:36 INFO - 'LANG': 'en_US.UTF-8', 06:36:36 INFO - 'LANGUAGE': 'en_US:en', 06:36:36 INFO - 'LOGNAME': 'cltbld', 06:36:36 INFO - 'MAIL': '/var/mail/cltbld', 06:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:36 INFO - 'MOZ_NO_REMOTE': '1', 06:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:36 INFO - 'NO_EM_RESTART': '1', 06:36:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:36 INFO - 'PWD': '/builds/slave/test', 06:36:36 INFO - 'SHELL': '/bin/bash', 06:36:36 INFO - 'SHLVL': '1', 06:36:36 INFO - 'TERM': 'linux', 06:36:36 INFO - 'TMOUT': '86400', 06:36:36 INFO - 'USER': 'cltbld', 06:36:36 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1476274921.318071-923543322', 06:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:36 INFO - '_': '/tools/buildbot/bin/python'} 06:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:36 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)) 06:36:36 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)) 06:36:36 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)) 06:36:36 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)) 06:36:36 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)) 06:36:36 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)) 06:36:36 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)) 06:36:36 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)) 06:36:36 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)) 06:36:36 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)) 06:36:36 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)) 06:36:36 INFO - Cleaning up... 06:36:36 INFO - Return code: 0 06:36:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:36: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')]} 06:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36: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')]} 06:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:36 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 0x7fb93fd1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2109ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106f60>, '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 0x2107d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21081d0>, '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': '4300f881736b422476174874000001bc-1476274921.318071-923543322', '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 06:36:36 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 06:36:36 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 06:36:36 INFO - Using env: {'DISPLAY': ':0', 06:36:36 INFO - 'HOME': '/home/cltbld', 06:36:36 INFO - 'LANG': 'en_US.UTF-8', 06:36:36 INFO - 'LANGUAGE': 'en_US:en', 06:36:36 INFO - 'LOGNAME': 'cltbld', 06:36:36 INFO - 'MAIL': '/var/mail/cltbld', 06:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:36 INFO - 'MOZ_NO_REMOTE': '1', 06:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:36 INFO - 'NO_EM_RESTART': '1', 06:36:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:36 INFO - 'PWD': '/builds/slave/test', 06:36:36 INFO - 'SHELL': '/bin/bash', 06:36:36 INFO - 'SHLVL': '1', 06:36:36 INFO - 'TERM': 'linux', 06:36:36 INFO - 'TMOUT': '86400', 06:36:36 INFO - 'USER': 'cltbld', 06:36:36 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1476274921.318071-923543322', 06:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:36 INFO - '_': '/tools/buildbot/bin/python'} 06:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:36:36 INFO - Cleaning up... 06:36:36 INFO - Return code: 0 06:36:36 INFO - Running post-action listener: _resource_record_post_action 06:36:36 INFO - Running post-action listener: _start_resource_monitoring 06:36:36 INFO - Starting resource monitoring. 06:36:36 INFO - [mozharness: 2016-10-12 13:36:36.940947Z] Finished create-virtualenv step (success) 06:36:36 INFO - [mozharness: 2016-10-12 13:36:36.941498Z] Running install step. 06:36:36 INFO - Running pre-action listener: _resource_record_pre_action 06:36:36 INFO - Running main action method: install 06:36:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:36:37 INFO - Reading from file tmpfile_stdout 06:36:37 INFO - Detecting whether we're running mozinstall >=1.0... 06:36:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:36:37 INFO - Reading from file tmpfile_stdout 06:36:37 INFO - Output received: 06:36:37 INFO - Usage: mozinstall [options] installer 06:36:37 INFO - Options: 06:36:37 INFO - -h, --help show this help message and exit 06:36:37 INFO - -d DEST, --destination=DEST 06:36:37 INFO - Directory to install application into. [default: 06:36:37 INFO - "/builds/slave/test"] 06:36:37 INFO - --app=APP Application being installed. [default: firefox] 06:36:37 INFO - mkdir: /builds/slave/test/build/application 06:36:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:36:53 INFO - Reading from file tmpfile_stdout 06:36:53 INFO - Output received: 06:36:53 INFO - /builds/slave/test/build/application/firefox/firefox 06:36:53 INFO - Running post-action listener: _resource_record_post_action 06:36:53 INFO - [mozharness: 2016-10-12 13:36:53.406373Z] Finished install step (success) 06:36:53 INFO - [mozharness: 2016-10-12 13:36:53.406619Z] Running run-tests step. 06:36:53 INFO - Running pre-action listener: _resource_record_pre_action 06:36:53 INFO - Running main action method: run_tests 06:36:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:36:53 INFO - Python 2.7.3 06:36:53 INFO - Return code: 0 06:36:53 INFO - grabbing minidump binary from tooltool 06:36:53 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')]} 06:36:53 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 0x2106f60>, '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 0x2107d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21081d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:36:53 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 06:36:53 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 06:36:53 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 06:36:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:36:53 INFO - Return code: 0 06:36:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:36:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:36:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:36:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:36:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:36:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 06:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 06:36:53 INFO - Using env: {'DISPLAY': ':0', 06:36:53 INFO - 'HOME': '/home/cltbld', 06:36:53 INFO - 'LANG': 'en_US.UTF-8', 06:36:53 INFO - 'LANGUAGE': 'en_US:en', 06:36:53 INFO - 'LOGNAME': 'cltbld', 06:36:53 INFO - 'MAIL': '/var/mail/cltbld', 06:36:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:36:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:53 INFO - 'MOZ_NO_REMOTE': '1', 06:36:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:36:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:53 INFO - 'NO_EM_RESTART': '1', 06:36:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:53 INFO - 'PWD': '/builds/slave/test', 06:36:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:36:53 INFO - 'SHELL': '/bin/bash', 06:36:53 INFO - 'SHLVL': '1', 06:36:53 INFO - 'TERM': 'linux', 06:36:53 INFO - 'TMOUT': '86400', 06:36:53 INFO - 'USER': 'cltbld', 06:36:53 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1476274921.318071-923543322', 06:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:53 INFO - '_': '/tools/buildbot/bin/python'} 06:36:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 06:36:53 INFO - mozversion application_buildid: 20161012051247 06:36:53 INFO - mozversion application_changeset: 4756eb1a2f82a6fb2e7ab5e3708d14aa76816076 06:36:53 INFO - mozversion application_display_name: Nightly 06:36:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:36:53 INFO - mozversion application_name: Firefox 06:36:53 INFO - mozversion application_remotingname: firefox 06:36:53 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 06:36:53 INFO - mozversion application_vendor: Mozilla 06:36:53 INFO - mozversion application_version: 52.0a1 06:36:53 INFO - mozversion platform_buildid: 20161012051247 06:36:53 INFO - mozversion platform_changeset: 4756eb1a2f82a6fb2e7ab5e3708d14aa76816076 06:36:53 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 06:36:53 INFO - mozversion platform_version: 52.0a1 06:36:53 INFO - using testdate: 1476279413 06:36:53 INFO - actual date: 1476279413 06:36:53 INFO - starting webserver on 'localhost:40798' 06:36:53 INFO - SUITE-START | Running 2 tests 06:36:53 INFO - TEST-START | dromaeo_css 06:36:53 INFO - operating with platform_type : linux_ 06:36:53 INFO - Initialising browser for dromaeo_css test... 06:36:53 INFO - TEST-INFO | started process 3440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3qZPi0/profile http://localhost:40798/getInfo.html) 06:36:58 INFO - PROCESS | 3440 | __metrics Screen width/height:1600/1200 06:36:58 INFO - PROCESS | 3440 | colorDepth:24 06:36:58 INFO - PROCESS | 3440 | Browser inner width/height: 1024/697 06:36:58 INFO - PROCESS | 3440 | __metrics 06:36:59 INFO - PROCESS | 3440 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:36:59 INFO - PROCESS | 3440 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:36:59 INFO - PROCESS | 3440 | console.error: PushService: 06:36:59 INFO - PROCESS | 3440 | stateChangeProcessEnqueue: Error transitioning state 06:36:59 INFO - PROCESS | 3440 | UnknownError 06:37:00 INFO - TEST-INFO | 3440: exit 0 06:37:00 INFO - Browser initialized. 06:37:00 INFO - Running cycle 1/1 for dromaeo_css test... 06:37:00 INFO - TEST-INFO | started process 3521 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3qZPi0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:37:12 INFO - PROCESS | 3521 | RSS: Main: 176222208 06:37:12 INFO - PROCESS | 3521 | 06:38:04 INFO - PROCESS | 3521 | 1476279484203 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] 06:40:17 INFO - PROCESS | 3521 | Cycle 1(1): loaded http://localhost:40798/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40798/tests/dromaeo/cssquery-ext.html) 06:40:19 INFO - PROCESS | 3521 | RSS: Main: 309329920 06:40:19 INFO - PROCESS | 3521 | 06:43:21 INFO - PROCESS | 3521 | Cycle 1(1): loaded http://localhost:40798/tests/dromaeo/cssquery-ext.html (next: http://localhost:40798/tests/dromaeo/cssquery-jquery.html) 06:43:22 INFO - PROCESS | 3521 | RSS: Main: 285773824 06:43:22 INFO - PROCESS | 3521 | 06:46:24 INFO - PROCESS | 3521 | Cycle 1(1): loaded http://localhost:40798/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40798/tests/dromaeo/cssquery-mootools.html) 06:46:25 INFO - PROCESS | 3521 | RSS: Main: 260128768 06:46:25 INFO - PROCESS | 3521 | 06:49:27 INFO - PROCESS | 3521 | Cycle 1(1): loaded http://localhost:40798/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40798/tests/dromaeo/cssquery-prototype.html) 06:49:28 INFO - PROCESS | 3521 | RSS: Main: 250654720 06:49:28 INFO - PROCESS | 3521 | 06:52:31 INFO - PROCESS | 3521 | Cycle 1(1): loaded http://localhost:40798/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40798/tests/dromaeo/cssquery-yui.html) 06:52:31 INFO - PROCESS | 3521 | RSS: Main: 223064064 06:52:31 INFO - PROCESS | 3521 | 06:55:34 INFO - PROCESS | 3521 | Cycle 1(1): loaded http://localhost:40798/tests/dromaeo/cssquery-yui.html (next: http://localhost:40798/tests/dromaeo/cssquery-dojo.html) 06:55:35 INFO - PROCESS | 3521 | RSS: Main: 318836736 06:55:35 INFO - PROCESS | 3521 | 06:55:35 INFO - PROCESS | 3521 | __start_tp_report 06:55:35 INFO - PROCESS | 3521 | _x_x_mozilla_page_load 06:55:35 INFO - PROCESS | 3521 | _x_x_mozilla_page_load_details 06:55:35 INFO - PROCESS | 3521 | |i|pagename|runs| 06:55:35 INFO - PROCESS | 3521 | |0;dojo.html;2471.3945083454555;2519.974800251997;2525.26767237501;2537.06128732369;2559.47530756195;4326.567343265672;4386.539413361599;4576;4578.816847326108;4615.630749540037;4427.09244604856;4435.223835828725;4437.534058923815;4442.82228710852;4445.91108177837;4054.3513037913867;4062.796860156995;4063.4920634920636;4063.5936406359424;4135.110951145503;4224.070704445033;4253.064325848309;4263.914721705564;4267.871963841089;4273.65810735142;4228.112096459732;4244.596763307481;4265.7014009019385;4266.679999000072;4293;4310.784460776948;4312.698111132222;4319.50325712544;4337.891552711191;4340.9798697306105;4117.053077792125;4145.067359844011;4195.223883581547;4231;4293.806778694966;4480.126375356806;4505.211587972091;4527.61515271199;4529.230030894722;4531.77341132942;4799.376081109468;4800.3279540864305;4805.977081922993;4832.830850920236;4886.022795440926;4835.661503694742;4851.708897466128;4853.126437241295;4886.315915771795;4906.582940450066;4605.999999999966;4621.052684199798;4652.581267685857;4665.0903073900945;4714.269288260325;5081.212412076134;5084.949150508522;5090.414602320707;5092.8472145835685;5154.768035438415;4862.17343051682;4869.366982292279;4872;4875.68308059975;4934.407871055496;4845.370101886802;4884.462709101996;4889.584385327216;4943.357363542788;4987.600991920638;4943.456219815817;4951.876203094951;4996.875078123076;5002.174641184164;5004.574611158019;4940.061388336205;4947.802087916443;4949.82675606352;4950.628702847301;4993.201087825931;3806.7715937043868;3813.1420430402936;3846.4999550058874;3901.765894046366;3903.0632648164237;3412.368711788327;3415.351083294166;3426.8971930842113;3435.587729472479;3475.2528206435736;4295.076558539929;4309.956900430955;4317.222899878052;4338.717983331137;4359.934600980988;4841.661083724105;4935.161022626162;4946.579540739005;4948.554630083309;5005.74971251436;4245.575442455792;4270.039241170712;4282.764447955392;4291.120320334324;4294.162638285567;4414.161309351213;4418.270985287456;4428.114377124523;4448.844290449819;4479.238529450001;4670.462896766915;4677.929831052469;4677.976610116995;4684.48470668233;4739.146953548395;4839.128956787812;4879.634027447884;4891.19295316283;4921.606271498343;4942.555170034714;4653.767311634337;4666.066786642617;4690.530946905282;4698.647601429975;4740.597049250714;4868.732219727949;4871.34236878017;4883.243097319921;4924.113659541317;4927.507249275044;4878.80484780619;4929.457759646364;4933.6299777516115;4943.555080042814;4982.377202849644;4684.0866031123605;4727.929081063856;4781.904361912672;4820.867096232453;4865.978144589534;4782.52174782519;4794.328793968777;4807.759612019455;4815.7351345676325;4838.879028024327;4699.107169637758;4750.928736068892;4763.857084287477;4764.737939413366;4765.213739732905;4721.055788842176;4770.356001939833;4848.684835485682;4864.36763220779;4930.038642464829;4691.249400095969;4691.272852707836;4720.740359280273;4724.173269677862;4783.354247176587 06:55:35 INFO - PROCESS | 3521 | |1;ext.html;552.312371097983;564.2101058518075;565.2538648983343;568.8805350876315;573.6013470637909;26200.2139935802;26674.33314167147;37946.430803537936;38849.417258741145;38902.416463753;39971.40042899352;40039.19921601566;40055.198896022135;40072.39891401631;40082.39876401849;7612.200718924516;7760.961195194044;7763.184865589116;7764.767056988271;7769.533827970312;7615.048118985127;7693.846123077535;7703.691852325928;7704.730334438295;7707.267809558083;7691.961540192319;7724.536527808349;7729.652165652531;7739.845203095934;7751.728689495869;7646.885296720554;7688.500247483896;7692.923070769277;7708.421868359839;7749.612519374009;7653.043369578802;7718.53688778675;7718.768436946901;7720.53676779395;7721.65252563636;37572.81213593942;37895;37923.241535169145;38050.80974595109;38057.23885522302;2835.758960488361;3015.175321704903;3143.6227652681823;3450.551428314303;3524.5770507539005;27353.863230683917;27509.44981100367;27689.86155069232;28474.71525284762;28782;3283.8850640227715;3381.1040074380307;3383.3571621392102;3428.142964258935;3462.515247865301;252832;253142;253640;254666;255592.72203639048;31216.531752023737;53089.2036619451;53437.1984420234;53524.464755352725;53548;33496.66503334984;33527.832360838525;33638;33718.15704607405;33755;13346.866531334757;13512.108304837331;13513.121647092907;13514.32428378577;13523;10444.63443779464;10445.216608754374;10447.94776026115;10451.059404653617;10456.424896630606;7628.313451789255;7742.148363680103;7816.68733250675;7836.882446763303;7848.0974687910475;3036.4686179918426;3082.5838511801066;3092.3196896682693;3137.576427182347;3145.308032232905;842.806154584449;900.3157600223747;944.15026476172;979.1041197304387;993.3245393132595;26288.8685556571;26563.335916601853;27327.45345093087;27531.449371012466;27536.17391478259;949.8337790886567;984.5963155106372;1000.8748906386702;1004.1665417703289;1047.2302857399804;13716.177029378268;14229.14625122496;14329.211893345757;14616.0198183321;14701.191434471206;345858;348480;348503;349066;349423;47439.52560474351;47902.5209747905;47906.281405778944;47958.28062579064;47988.520114798404;1139.1342579639368;1160.843286156375;1174.518447436547;1179.9557391708229;1195.9162858599814;25406.237812865642;26310.736892631594;26652.60021099724;27173.59239611447;27233.455330892873;40482.39276410915;40796;40879.1824163521;40900.386494202015;40959.38560921648;243274;244171;244415;244475;245119;24605.87697061503;24677.753222467545;24800.50398992046;25073;25085.498290034462;40245.79877100596;43918.34122488229;44101.77949110234;44770;44810.55189448064;34638.30723385569;34762;34923.65076349204;35426.64573354233;35513;35092.64907350894;35134.47298290579;35394.29211415809;35903;35965.28069438649;34401.31197375988;34752.304953900275;35137.29725405529;35145.970805839446;35652.46521302235;30571.388572228876;32683.34633307368;32714.509282360308;32801.50797738084;32895.177620559676;24534.754652453248;24928.875355623106;25036.874815625804;25169.622455662815;25420.364490887874 06:55:35 INFO - PROCESS | 3521 | |2;jquery.html;330.86269198282713;339.45347989736536;358.70765326259107;360.25607121294524;376.59892214791245;11980.161388702783;13005.089643724943;15503.612409689764;15913.44302949397;16098;16344.509664710047;16592;16792.66414671706;16881;16934.661306773858;4486.753228572427;4850.87872803181;5056.241563765446;5062.607782859706;5070.771815268304;5869.383714709937;6004.09938509225;6050.818475445743;6068.514518838504;6070;5828.591998560102;5995.490383317423;6014.488768454687;6015.398460153971;6037.184980027684;5944.851378715523;5972.6715030673295;5981.132735753292;5981.790637327695;5984.521238300926;4640.65195110368;4889.973105647819;4906.779194936201;4918.065567542156;5236.450172731885;11940.343281119534;12149.574764883188;12211.206271592408;13131.474741010348;19401.32095376669;1752.2465339903836;1886.1700851625242;1930.2664987304875;2076.7404074490687;2184.726909136358;9192;9647.855282170773;9654.517274136335;11110.888891111146;12964.87035129646;1626.9267882945296;1692.5514738594159;1701.5150682055678;1720.320473412995;1733.0554847608084;67510;68668.31331686719;70773.2922670777;70862.2913770866;74111;8076.2540736149995;8323.750287491384;8663.78340541479;8764;9479.668211612698;10783.191260655482;10847.403392813314;10865.891341086646;10872.45637718111;10893.128549716004;6313.779017734358;6437.742490300336;6494.220693516808;6512.283648798629;6549.803505894831;6424.357564243538;6486.091947127406;6597.703103360361;6659.800205993828;6718.294579069127;3230.709236168756;3314.4034073866455;3397.235621985083;3403.353362861098;3420.8973730788116;1657.2790835986384;1659.8174200837898;1686.8819182657342;1729.1008775211817;1757.9648407031789;776.5185584937375;826.3760860550246;853.4282031039095;875.3959767760225;892.5775911338644;16142.919285403732;16849.241784119746;17168.914155429142;17292;17338.826611733723;792.4056957282038;819.4509678515409;823.9752807415787;838.8322335532918;877.4998250996998;8929.508877011827;8970.955145224232;9071.27429805614;9096.81806363869;9360.485173315397;336307;356125;369826;370766;375769.36345954833;77683.34749787577;79299.60350198211;79544.60227698824;80800;81310.59344703356;850.4812064640564;874.2132081127037;877.8244351129672;878.5168157513469;885.274075258282;14261.714765704835;14391.784123238369;14546.418143274574;14741.410343586136;15180;37781.81109094547;37940.241195176495;38050.80974595109;38584.42123368096;38977.76355783174;50423;51219;52000.57995070461;52032.219516708035;52937;7044.260352663102;7161.713531458683;7709.2290770922455;7755.2244775521995;8064.83870322602;10775.137988961022;10928.071113955402;11172.776544469227;11270.267432616854;11319.603813866475;9018.774530636787;9628.855567166638;9716;9862.506874656096;10029.197664186993;8768.605412756313;9679.128878400978;9725.31922765428;9921.454320012468;10318.329308594917;8942.552872356486;9507.191888689262;9689.370190937567;9989.700308990741;10346;7015.298470152944;7167.820804479929;7299.671514781954;7315.451341149329;7423.146338171179;7840.921590784247;9629.229661626912;9847.753806154904;9912.603495860374;10031.799364012533 06:55:35 INFO - PROCESS | 3521 | |3;mootools.html;1151.2862025544164;1324.1657755613965;1356.3218390804598;1410.7742761158217;1645.169189559273;6335.176427064481;6919.757808476698;7202.963985180067;7208.135023797146;7395.889061664079;7297.781066568012;7348.2284360142085;7354.227806080365;7360.227176146508;7368.042154519918;2059.6601560742497;2063.432556047084;2084.4267826347723;2087.436392174112;2089.8955052247325;2035.5114772454579;2055.43475544225;2062.2369723202437;2103.3479621317365;2103.684447332897;1970.6945423459315;2017.4149496645955;2028.9391318260402;2031.8476114291414;2032.0550943811124;2006.0872303102126;2013.577148798754;2014.6776515757556;2015.586804705032;2018.041430320586;2009.9799002009938;2023.2716222160159;2053.712480252766;2055.085486958304;2060.1450398084776;7261;7273.236310187407;7339.77980660581;7429.925700742978;7431.628418579049;4373.803178856959;4500.819967201308;4503.752293623849;4504.684672072956;4524.8190072397065;2682.0746842339363;2789.623400840881;2842.161562339115;2842.6020357150014;2847.330877243846;892.7678803511069;894.4901406198469;897.7710683775596;907.7503686486203;908.3051465628733;9914.80170396588;10004.149647279917;10042.196624269967;10049.296549241555;10057.346272492265;3744.8689295874515;3776.8489260429274;3948.4274780156716;3961.841526338972;3979.383195604686;7854.764357069297;7901.565413902291;7902.723404680809;7930.048394192619;7933.325667318227;4250.659947204216;4256.7445953242905;4257.893552661209;4260.062786187096;4265.296226122655;3569.5538057742783;3660.908477288036;3830.0807806126327;3946.7039972002217;3952.071263253133;3179.825109618947;3189.649138594753;3234.2884565395575;3237.482002879528;3363.613184483767;980.7352014955922;991.3655260633201;1015.8577799108131;1028.2596530498179;1033.0186322993186;595.9314678811992;640.0015975078799;685.1880521581942;712.6828561290176;718.2637796258772;4586.3579098926175;4724.551167639069;4741.95258047422;4749.857504274877;5089.4147173074825;388.46391979069267;397.6917888636272;403.9333509970822;406.87183537185695;410.8787907567275;3215.903522894317;3220.66183050781;3225.177579717204;3242.2218667519624;3318.253392986607;8190.7952301192945;8568.143185681382;8690.217880390795;8796.120387961153;8803.031666516677;8552.144785521397;8756.168164024408;8759.912400876037;8776.385653004356;8781.990071141772;6663.300353462913;6729.730810767514;6733.158355205599;6737.59574425536;6748.865022699617;4681.695689780154;4728.267118596623;4731.384919960383;4879.902401952012;4918;8013.3589312856;8042.316403105568;8305.127961563949;8326.791830204293;8342.749717508485;8290.253877151084;8337.416380853281;8386.454880432751;8450.450720703135;8463.195996380335;5774.913376299275;6459.741610335534;6594.208694956444;6597.80206593803;6609.1408116944485;6386.946153884557;6752.696128674123;6999.440044796303;7004.824879378057;7258;6449.419552240133;6465.741370345134;6493.902591461227;6525.0538671893255;6617.305182955913;6213.782517611862;6298.653574053471;6347.587406818542;6561.901571476336;6644.335566443317;5866.5893387462465;5992.4307190818545;5994.340622531605;5995.160677505066;6006.429389208019;4201.831926722897;4273.41933175647;4326.242907491113;4379.978100109479;4455.866324010285;4259.488861336659;4276.87169384919;4317.330813723878;4458.621017213443;4474.463064432289 06:55:35 INFO - PROCESS | 3521 | |4;prototype.html;280.12321433911853;285.3963866422516;294.2349890285257;304.4702218140436;307.39750089823946;4828.372311599492;4845.927311090328;4878.926816097762;4879.585235254999;4884.340614017106;4525.932111018337;4612.33121197427;4681.602063824579;4738.6355687461855;4803.327534145223;3763.962360376402;3769.6795772359383;3775.9811200943955;3786.1481166737403;3804.7907365094907;3767.6420740029653;3788.5074940257728;3796.7152463565203;3830.578636349999;3831.7355272759924;3532.717382609398;3555.004598712365;3672.981635091821;3761.8119094045323;3762.43563465481;3743.6630703236565;3752.43713442983;3754.3805272130066;3756.286305601927;3758.849646014156;3336.5996080470254;3341.732661387083;3345.916352091193;3347.8493467794005;3353.0779035765117;4458.732476051415;4710;4715.3634259374885;4717.127331443694;4729.621630269605;4238.597333253336;4253.447051883235;4272.743635381856;4273.764942928137;4282.614564689162;5035.345405097314;5040.092783299005;5047.798088076473;5049.368828896388;5104.591632669415;3588.946165807515;3593.425051991695;3595.8741444049333;3598.5321908152036;3603.8738644147593;5160.938352427706;5198.740062996872;5223.425423203445;5224.760648398017;5240.423553409122;3638.235970446183;3639.5259919732553;3646.507721457622;3653.397189463709;3669.211119609297;3713.665770080706;3717.3308804414924;3724.7522080102926;3726.888193354204;3762.8682996095004;4170.436991006236;4275.700700950903;4290.549492303326;4291.69958102936;4294.720843145185;4997.85006449807;5006.324146240284;5006.924896126561;5008.899822003539;5013.5989120870245;1265.9240445573296;1281.333706472629;1282.58316047285;1283.6726634708089;1287.9310172556943;808.5754978636263;816.2082779703796;828.3331917806104;839.7354833227514;842.5281842168405;4398.934015989763;4452.354408610733;4517.232070547949;4537.342085397599;4548.522405147478;5170.353705786777;5177.223416487482;5177.508136727005;5178.559822415062;5182.144946083929;4343.1530851484285;4517.531802164244;4522.592966632953;4557.313793896214;4565.543445655474;2741.3420779012895;2769;2769.407590635393;2780.958285625717;2783.5546312590295;4885.682430641997;4912.771807048238;4915.21356582945;4940.580050695731;4946.318251794407;4991.875203119951;5211.296474975906;5242.580593552507;5278.762455689426;5289.603279754034;4871.318015477836;4872.9512704872495;4886.584640305543;4894.877628059327;4901;5101.69389836611;5104.9489505104475;5111.156659151347;5117.565006974449;5135.435102138687;4897.219159622688;4903.019396120719;5012.974935125447;5030.798768049237;5072.691925173963;4893.531940417789;4899.755012249445;4902.362692849907;4912.92630610534;4916.70499770015;3582.4743555792584;3590.7666001709804;3595.424732042861;3608.530890984155;3614.367485690046;4977;5118.309028281284;5138.563222126161;5149.201873709581;5157.535821776059;5001.42483614389;5004.024215277986;5004.674696144739;5007.47421520735;5024.924626130538;4994.475580064186;4997.85006449807;5002.374703162105;5003.474635163256;5026.170681837456;4698.271767875985;4902.313676085422;4937.851864444073;4939.629527785359;4956.430010548689;4805.687630304019;4885.5358740919555;4929.876753081202;5001.64988450805;5014.147594908802;4929.4225847728385;4937.851864444073;4966.652334336562;4967.776450059829;4985.725785081855 06:55:35 INFO - PROCESS | 3521 | |5;yui.html;561.3095892052775;572.1674962928939;584.0217635460602;589.1133843565433;598.8712426828231;11941.701457463569;12748.617541473748;13072.281024543647;13107.213567185963;13933.372998215105;11765.588204412847;11881.227720198181;11888.583899563517;11899.702507437296;11912.225705329169;545.9563234941215;731.3746746531718;755.7808235611666;761.801931497809;762.6491813765674;561.1078385367285;724.4566575068699;745.1356426545209;751.4176513202258;751.9622920369909;794.5947566740975;796.80079980005;797.5693125712138;797.6649807081011;797.7447216890597;564.7289301135437;788.5071830106184;790.0519376747925;790.2097902097902;791.1692722641233;424.21520187652595;558.4638746803074;573.2919843992707;576.7548791763526;577.9219805326269;11906.821397679041;11954.163208575403;11958.402079896057;11959.461824217931;11997.520099196021;11473.827892581618;12416.423134176091;12561.183523071062;12579.964763393651;12610.936945315214;11669.241499302518;11695.766084678344;11776.293422394683;11783.410829458579;11952.099639147908;3176.745860331168;3188.601424821897;3290.2596915694016;4054.9391759123637;4122.2786012447705;57617;58235.41764582384;58271;59181.40818591802;59444.70277648627;9688.951555242178;9796.118349348593;9851;9890.159336456338;9987.550560224807;17285.827141728423;17444.5638859027;17452.650946981244;17493;17531.123443827757;5907.556933230025;6009.06859436788;6095.3904609538695;6203.379662033851;6286.874262514724;3164.3354895472207;3392.5759280089987;3416.6754158354915;3450.7584469087424;3485.4771784232566;2727.7272272772566;3045.680203578637;3221.855016524262;3224.98412999909;3225.8064516129107;522.3888050980362;526.8156145349097;529.3145376737135;529.9533421492522;534.1053734993869;384.8018270590648;495.805109685663;530.9283246761715;539.1185411851573;569.6752850875044;7095.50331476802;7241.2396698346965;7855.3187676408015;7918.920810791818;7931.484453510503;452.94791099024036;460.6084827896261;529.534010071135;554.3403350013471;589.1898639370866;3606.531150950412;3835.194609132058;3952.1700442906736;3975.383815508601;4027.154297597479;50875.236871446956;51263.7436812821;94694;96206;99641;62165;84419.57790211009;84893;85643;86861;69893.65053174803;70455.2954470459;70593.29406705867;70829.64585177042;75168;7300.744473943387;7381.704731810667;7441.962790186014;7553.584552849646;7622.771316860503;42571.574284258;44259.77870110629;45393.773031135956;45473;45805.77097114493;35333.46999795057;35507.82246088753;55309.170362443794;56325.43674563202;58297;11188.272762270752;11216.158788091088;11325.830112548483;11571;11706.590269340531;12323;12584.433700483318;13003.154794938298;13436.731265374834;13565.728685426038;11247.493862776359;11265;11445.25605835618;11481.36852473122;11726.355050472306;10186.898131018595;11563.6530904073;11633.418329083343;12044.879551204376;12049.397530123633;10739.946300268448;11282.830757538479;11374.488148033193;12022.879771202526;12128.75742485163;9594.616215351307;9912.058354456316;10114.443705595968;10246.743831404274;10403.167746580104;9545.522723863918;9553.665621703207;9607.004199350356;9669.758256043655;10220.02057387129 06:55:35 INFO - PROCESS | 3521 | __end_tp_report 06:55:35 INFO - PROCESS | 3521 | __start_cc_report 06:55:35 INFO - PROCESS | 3521 | _x_x_mozilla_cycle_collect,1290 06:55:35 INFO - PROCESS | 3521 | __end_cc_report 06:55:35 INFO - PROCESS | 3521 | __startTimestamp1476280535218__endTimestamp 06:55:35 INFO - PROCESS | 3521 | 06:55:35 INFO - PROCESS | 3521 | ------- Summary: start ------- 06:55:35 INFO - PROCESS | 3521 | Number of tests: 6 06:55:35 INFO - PROCESS | 3521 | 06:55:35 INFO - PROCESS | 3521 | [#0] dojo.html Cycles:165 Average:4530.44 Median:4691.25 stddev:509.75 (10.9%) stddev-sans-first:485.05 06:55:35 INFO - PROCESS | 3521 | Values: 2471.4 2520.0 2525.3 2537.1 2559.5 4326.6 4386.5 4576.0 4578.8 4615.6 4427.1 4435.2 4437.5 4442.8 4445.9 4054.4 4062.8 4063.5 4063.6 4135.1 4224.1 4253.1 4263.9 4267.9 4273.7 4228.1 4244.6 4265.7 4266.7 4293.0 4310.8 4312.7 4319.5 4337.9 4341.0 4117.1 4145.1 4195.2 4231.0 4293.8 4480.1 4505.2 4527.6 4529.2 4531.8 4799.4 4800.3 4806.0 4832.8 4886.0 4835.7 4851.7 4853.1 4886.3 4906.6 4606.0 4621.1 4652.6 4665.1 4714.3 5081.2 5084.9 5090.4 5092.8 5154.8 4862.2 4869.4 4872.0 4875.7 4934.4 4845.4 4884.5 4889.6 4943.4 4987.6 4943.5 4951.9 4996.9 5002.2 5004.6 4940.1 4947.8 4949.8 4950.6 4993.2 3806.8 3813.1 3846.5 3901.8 3903.1 3412.4 3415.4 3426.9 3435.6 3475.3 4295.1 4310.0 4317.2 4338.7 4359.9 4841.7 4935.2 4946.6 4948.6 5005.7 4245.6 4270.0 4282.8 4291.1 4294.2 4414.2 4418.3 4428.1 4448.8 4479.2 4670.5 4677.9 4678.0 4684.5 4739.1 4839.1 4879.6 4891.2 4921.6 4942.6 4653.8 4666.1 4690.5 4698.6 4740.6 4868.7 4871.3 4883.2 4924.1 4927.5 4878.8 4929.5 4933.6 4943.6 4982.4 4684.1 4727.9 4781.9 4820.9 4866.0 4782.5 4794.3 4807.8 4815.7 4838.9 4699.1 4750.9 4763.9 4764.7 4765.2 4721.1 4770.4 4848.7 4864.4 4930.0 4691.2 4691.3 4720.7 4724.2 4783.4 06:55:35 INFO - PROCESS | 3521 | 06:55:35 INFO - PROCESS | 3521 | [#1] ext.html Cycles:180 Average:42784.61 Median:348491.50 stddev:75183.54 (21.6%) stddev-sans-first:75327.58 06:55:35 INFO - PROCESS | 3521 | Values: 552.3 564.2 565.3 568.9 573.6 26200.2 26674.3 37946.4 38849.4 38902.4 39971.4 40039.2 40055.2 40072.4 40082.4 7612.2 7761.0 7763.2 7764.8 7769.5 7615.0 7693.8 7703.7 7704.7 7707.3 7692.0 7724.5 7729.7 7739.8 7751.7 7646.9 7688.5 7692.9 7708.4 7749.6 7653.0 7718.5 7718.8 7720.5 7721.7 37572.8 37895.0 37923.2 38050.8 38057.2 2835.8 3015.2 3143.6 3450.6 3524.6 27353.9 27509.4 27689.9 28474.7 28782.0 3283.9 3381.1 3383.4 3428.1 3462.5 252832.0 253142.0 253640.0 254666.0 255592.7 31216.5 53089.2 53437.2 53524.5 53548.0 33496.7 33527.8 33638.0 33718.2 33755.0 13346.9 13512.1 13513.1 13514.3 13523.0 10444.6 10445.2 10447.9 10451.1 10456.4 7628.3 7742.1 7816.7 7836.9 7848.1 3036.5 3082.6 3092.3 3137.6 3145.3 842.8 900.3 944.2 979.1 993.3 26288.9 26563.3 27327.5 27531.4 27536.2 949.8 984.6 1000.9 1004.2 1047.2 13716.2 14229.1 14329.2 14616.0 14701.2 345858.0 348480.0 348503.0 349066.0 349423.0 47439.5 47902.5 47906.3 47958.3 47988.5 1139.1 1160.8 1174.5 1180.0 1195.9 25406.2 26310.7 26652.6 27173.6 27233.5 40482.4 40796.0 40879.2 40900.4 40959.4 243274.0 244171.0 244415.0 244475.0 245119.0 24605.9 24677.8 24800.5 25073.0 25085.5 40245.8 43918.3 44101.8 44770.0 44810.6 34638.3 34762.0 34923.7 35426.6 35513.0 35092.6 35134.5 35394.3 35903.0 35965.3 34401.3 34752.3 35137.3 35146.0 35652.5 30571.4 32683.3 32714.5 32801.5 32895.2 24534.8 24928.9 25036.9 25169.6 25420.4 06:55:35 INFO - PROCESS | 3521 | 06:55:35 INFO - PROCESS | 3521 | [#2] jquery.html Cycles:180 Average:23176.08 Median:29382.80 stddev:60177.32 (204.8%) stddev-sans-first:60321.68 06:55:35 INFO - PROCESS | 3521 | Values: 330.9 339.5 358.7 360.3 376.6 11980.2 13005.1 15503.6 15913.4 16098.0 16344.5 16592.0 16792.7 16881.0 16934.7 4486.8 4850.9 5056.2 5062.6 5070.8 5869.4 6004.1 6050.8 6068.5 6070.0 5828.6 5995.5 6014.5 6015.4 6037.2 5944.9 5972.7 5981.1 5981.8 5984.5 4640.7 4890.0 4906.8 4918.1 5236.5 11940.3 12149.6 12211.2 13131.5 19401.3 1752.2 1886.2 1930.3 2076.7 2184.7 9192.0 9647.9 9654.5 11110.9 12964.9 1626.9 1692.6 1701.5 1720.3 1733.1 67510.0 68668.3 70773.3 70862.3 74111.0 8076.3 8323.8 8663.8 8764.0 9479.7 10783.2 10847.4 10865.9 10872.5 10893.1 6313.8 6437.7 6494.2 6512.3 6549.8 6424.4 6486.1 6597.7 6659.8 6718.3 3230.7 3314.4 3397.2 3403.4 3420.9 1657.3 1659.8 1686.9 1729.1 1758.0 776.5 826.4 853.4 875.4 892.6 16142.9 16849.2 17168.9 17292.0 17338.8 792.4 819.5 824.0 838.8 877.5 8929.5 8971.0 9071.3 9096.8 9360.5 336307.0 356125.0 369826.0 370766.0 375769.4 77683.3 79299.6 79544.6 80800.0 81310.6 850.5 874.2 877.8 878.5 885.3 14261.7 14391.8 14546.4 14741.4 15180.0 37781.8 37940.2 38050.8 38584.4 38977.8 50423.0 51219.0 52000.6 52032.2 52937.0 7044.3 7161.7 7709.2 7755.2 8064.8 10775.1 10928.1 11172.8 11270.3 11319.6 9018.8 9628.9 9716.0 9862.5 10029.2 8768.6 9679.1 9725.3 9921.5 10318.3 8942.6 9507.2 9689.4 9989.7 10346.0 7015.3 7167.8 7299.7 7315.5 7423.1 7840.9 9629.2 9847.8 9912.6 10031.8 06:55:35 INFO - PROCESS | 3521 | 06:55:35 INFO - PROCESS | 3521 | [#3] mootools.html Cycles:180 Average:4749.57 Median:4729.83 stddev:2664.96 (56.3%) stddev-sans-first:2658.71 06:55:35 INFO - PROCESS | 3521 | Values: 1151.3 1324.2 1356.3 1410.8 1645.2 6335.2 6919.8 7203.0 7208.1 7395.9 7297.8 7348.2 7354.2 7360.2 7368.0 2059.7 2063.4 2084.4 2087.4 2089.9 2035.5 2055.4 2062.2 2103.3 2103.7 1970.7 2017.4 2028.9 2031.8 2032.1 2006.1 2013.6 2014.7 2015.6 2018.0 2010.0 2023.3 2053.7 2055.1 2060.1 7261.0 7273.2 7339.8 7429.9 7431.6 4373.8 4500.8 4503.8 4504.7 4524.8 2682.1 2789.6 2842.2 2842.6 2847.3 892.8 894.5 897.8 907.8 908.3 9914.8 10004.1 10042.2 10049.3 10057.3 3744.9 3776.8 3948.4 3961.8 3979.4 7854.8 7901.6 7902.7 7930.0 7933.3 4250.7 4256.7 4257.9 4260.1 4265.3 3569.6 3660.9 3830.1 3946.7 3952.1 3179.8 3189.6 3234.3 3237.5 3363.6 980.7 991.4 1015.9 1028.3 1033.0 595.9 640.0 685.2 712.7 718.3 4586.4 4724.6 4742.0 4749.9 5089.4 388.5 397.7 403.9 406.9 410.9 3215.9 3220.7 3225.2 3242.2 3318.3 8190.8 8568.1 8690.2 8796.1 8803.0 8552.1 8756.2 8759.9 8776.4 8782.0 6663.3 6729.7 6733.2 6737.6 6748.9 4681.7 4728.3 4731.4 4879.9 4918.0 8013.4 8042.3 8305.1 8326.8 8342.7 8290.3 8337.4 8386.5 8450.5 8463.2 5774.9 6459.7 6594.2 6597.8 6609.1 6386.9 6752.7 6999.4 7004.8 7258.0 6449.4 6465.7 6493.9 6525.1 6617.3 6213.8 6298.7 6347.6 6561.9 6644.3 5866.6 5992.4 5994.3 5995.2 6006.4 4201.8 4273.4 4326.2 4380.0 4455.9 4259.5 4276.9 4317.3 4458.6 4474.5 06:55:35 INFO - PROCESS | 3521 | 06:55:35 INFO - PROCESS | 3521 | [#4] prototype.html Cycles:180 Average:4171.05 Median:4804.51 stddev:1206.72 (25.1%) stddev-sans-first:1174.23 06:55:35 INFO - PROCESS | 3521 | Values: 280.1 285.4 294.2 304.5 307.4 4828.4 4845.9 4878.9 4879.6 4884.3 4525.9 4612.3 4681.6 4738.6 4803.3 3764.0 3769.7 3776.0 3786.1 3804.8 3767.6 3788.5 3796.7 3830.6 3831.7 3532.7 3555.0 3673.0 3761.8 3762.4 3743.7 3752.4 3754.4 3756.3 3758.8 3336.6 3341.7 3345.9 3347.8 3353.1 4458.7 4710.0 4715.4 4717.1 4729.6 4238.6 4253.4 4272.7 4273.8 4282.6 5035.3 5040.1 5047.8 5049.4 5104.6 3588.9 3593.4 3595.9 3598.5 3603.9 5160.9 5198.7 5223.4 5224.8 5240.4 3638.2 3639.5 3646.5 3653.4 3669.2 3713.7 3717.3 3724.8 3726.9 3762.9 4170.4 4275.7 4290.5 4291.7 4294.7 4997.9 5006.3 5006.9 5008.9 5013.6 1265.9 1281.3 1282.6 1283.7 1287.9 808.6 816.2 828.3 839.7 842.5 4398.9 4452.4 4517.2 4537.3 4548.5 5170.4 5177.2 5177.5 5178.6 5182.1 4343.2 4517.5 4522.6 4557.3 4565.5 2741.3 2769.0 2769.4 2781.0 2783.6 4885.7 4912.8 4915.2 4940.6 4946.3 4991.9 5211.3 5242.6 5278.8 5289.6 4871.3 4873.0 4886.6 4894.9 4901.0 5101.7 5104.9 5111.2 5117.6 5135.4 4897.2 4903.0 5013.0 5030.8 5072.7 4893.5 4899.8 4902.4 4912.9 4916.7 3582.5 3590.8 3595.4 3608.5 3614.4 4977.0 5118.3 5138.6 5149.2 5157.5 5001.4 5004.0 5004.7 5007.5 5024.9 4994.5 4997.9 5002.4 5003.5 5026.2 4698.3 4902.3 4937.9 4939.6 4956.4 4805.7 4885.5 4929.9 5001.6 5014.1 4929.4 4937.9 4966.7 4967.8 4985.7 06:55:35 INFO - PROCESS | 3521 | 06:55:35 INFO - PROCESS | 3521 | [#5] yui.html Cycles:180 Average:16378.18 Median:25685.52 stddev:22932.00 (89.3%) stddev-sans-first:22965.57 06:55:35 INFO - PROCESS | 3521 | Values: 561.3 572.2 584.0 589.1 598.9 11941.7 12748.6 13072.3 13107.2 13933.4 11765.6 11881.2 11888.6 11899.7 11912.2 546.0 731.4 755.8 761.8 762.6 561.1 724.5 745.1 751.4 752.0 794.6 796.8 797.6 797.7 797.7 564.7 788.5 790.1 790.2 791.2 424.2 558.5 573.3 576.8 577.9 11906.8 11954.2 11958.4 11959.5 11997.5 11473.8 12416.4 12561.2 12580.0 12610.9 11669.2 11695.8 11776.3 11783.4 11952.1 3176.7 3188.6 3290.3 4054.9 4122.3 57617.0 58235.4 58271.0 59181.4 59444.7 9689.0 9796.1 9851.0 9890.2 9987.6 17285.8 17444.6 17452.7 17493.0 17531.1 5907.6 6009.1 6095.4 6203.4 6286.9 3164.3 3392.6 3416.7 3450.8 3485.5 2727.7 3045.7 3221.9 3225.0 3225.8 522.4 526.8 529.3 530.0 534.1 384.8 495.8 530.9 539.1 569.7 7095.5 7241.2 7855.3 7918.9 7931.5 452.9 460.6 529.5 554.3 589.2 3606.5 3835.2 3952.2 3975.4 4027.2 50875.2 51263.7 94694.0 96206.0 99641.0 62165.0 84419.6 84893.0 85643.0 86861.0 69893.7 70455.3 70593.3 70829.6 75168.0 7300.7 7381.7 7442.0 7553.6 7622.8 42571.6 44259.8 45393.8 45473.0 45805.8 35333.5 35507.8 55309.2 56325.4 58297.0 11188.3 11216.2 11325.8 11571.0 11706.6 12323.0 12584.4 13003.2 13436.7 13565.7 11247.5 11265.0 11445.3 11481.4 11726.4 10186.9 11563.7 11633.4 12044.9 12049.4 10739.9 11282.8 11374.5 12022.9 12128.8 9594.6 9912.1 10114.4 10246.7 10403.2 9545.5 9553.7 9607.0 9669.8 10220.0 06:55:35 INFO - PROCESS | 3521 | -------- Summary: end -------- 06:55:35 INFO - PROCESS | 3521 | 06:55:36 INFO - TEST-INFO | 3521: exit 0 06:55:36 INFO - TEST-OK | dromaeo_css | took 1122474ms 06:55:36 INFO - TEST-START | kraken 06:55:36 INFO - operating with platform_type : linux_ 06:55:36 INFO - Initialising browser for kraken test... 06:55:36 INFO - TEST-INFO | started process 3829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7hizVd/profile http://localhost:40798/getInfo.html) 06:55:40 INFO - PROCESS | 3829 | __metrics Screen width/height:1600/1200 06:55:40 INFO - PROCESS | 3829 | colorDepth:24 06:55:40 INFO - PROCESS | 3829 | Browser inner width/height: 1024/697 06:55:40 INFO - PROCESS | 3829 | __metrics 06:55:41 INFO - PROCESS | 3829 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:55:41 INFO - PROCESS | 3829 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:55:42 INFO - PROCESS | 3829 | console.error: PushService: 06:55:42 INFO - PROCESS | 3829 | stateChangeProcessEnqueue: Error transitioning state 06:55:42 INFO - PROCESS | 3829 | UnknownError 06:55:42 INFO - TEST-INFO | 3829: exit 0 06:55:42 INFO - Browser initialized. 06:55:42 INFO - Running cycle 1/1 for kraken test... 06:55:42 INFO - TEST-INFO | started process 3912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7hizVd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:55:54 INFO - PROCESS | 3912 | RSS: Main: 176623616 06:55:54 INFO - PROCESS | 3912 | 06:55:57 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40798/tests/kraken/driver.html?testName=audio-beat-detection) 06:55:58 INFO - PROCESS | 3912 | RSS: Main: 243077120 06:55:58 INFO - PROCESS | 3912 | 06:56:01 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40798/tests/kraken/driver.html?testName=audio-dft) 06:56:02 INFO - PROCESS | 3912 | RSS: Main: 220151808 06:56:02 INFO - PROCESS | 3912 | 06:56:05 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40798/tests/kraken/driver.html?testName=audio-fft) 06:56:06 INFO - PROCESS | 3912 | RSS: Main: 301944832 06:56:06 INFO - PROCESS | 3912 | 06:56:08 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40798/tests/kraken/driver.html?testName=audio-oscillator) 06:56:08 INFO - PROCESS | 3912 | RSS: Main: 212357120 06:56:08 INFO - PROCESS | 3912 | 06:56:11 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40798/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:56:11 INFO - PROCESS | 3912 | RSS: Main: 215056384 06:56:11 INFO - PROCESS | 3912 | 06:56:14 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40798/tests/kraken/driver.html?testName=imaging-darkroom) 06:56:15 INFO - PROCESS | 3912 | RSS: Main: 251744256 06:56:15 INFO - PROCESS | 3912 | 06:56:19 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40798/tests/kraken/driver.html?testName=imaging-desaturate) 06:56:19 INFO - PROCESS | 3912 | RSS: Main: 250654720 06:56:19 INFO - PROCESS | 3912 | 06:56:22 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40798/tests/kraken/driver.html?testName=json-parse-financial) 06:56:23 INFO - PROCESS | 3912 | RSS: Main: 249823232 06:56:23 INFO - PROCESS | 3912 | 06:56:24 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40798/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:56:25 INFO - PROCESS | 3912 | RSS: Main: 212123648 06:56:25 INFO - PROCESS | 3912 | 06:56:27 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40798/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:56:28 INFO - PROCESS | 3912 | RSS: Main: 220172288 06:56:28 INFO - PROCESS | 3912 | 06:56:30 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40798/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:56:30 INFO - PROCESS | 3912 | RSS: Main: 228986880 06:56:30 INFO - PROCESS | 3912 | 06:56:33 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40798/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:56:34 INFO - PROCESS | 3912 | RSS: Main: 237531136 06:56:34 INFO - PROCESS | 3912 | 06:56:37 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40798/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:56:38 INFO - PROCESS | 3912 | RSS: Main: 234287104 06:56:38 INFO - PROCESS | 3912 | 06:56:39 INFO - PROCESS | 3912 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40798/tests/kraken/driver.html?testName=ai-astar) 06:56:40 INFO - PROCESS | 3912 | RSS: Main: 284209152 06:56:40 INFO - PROCESS | 3912 | 06:56:40 INFO - PROCESS | 3912 | __start_tp_report 06:56:40 INFO - PROCESS | 3912 | _x_x_mozilla_page_load 06:56:40 INFO - PROCESS | 3912 | _x_x_mozilla_page_load_details 06:56:40 INFO - PROCESS | 3912 | |i|pagename|runs| 06:56:40 INFO - PROCESS | 3912 | |0;ai-astar;113;115;117;116;116;118;115;115;117;115 06:56:40 INFO - PROCESS | 3912 | |1;audio-beat-detection;151;131;126;169;138;132;132;129;166;131 06:56:40 INFO - PROCESS | 3912 | |2;audio-dft;159;160;163;161;161;161;162;161;163;161 06:56:40 INFO - PROCESS | 3912 | |3;audio-fft;76;76;77;122;77;75;76;76;107;77 06:56:40 INFO - PROCESS | 3912 | |4;audio-oscillator;83;83;134;84;84;84;119;84;84;127 06:56:40 INFO - PROCESS | 3912 | |5;imaging-gaussian-blur;117;122;117;117;116;117;117;117;117;116 06:56:40 INFO - PROCESS | 3912 | |6;imaging-darkroom;147;147;147;147;146;147;147;147;147;146 06:56:40 INFO - PROCESS | 3912 | |7;imaging-desaturate;95;96;96;96;95;95;95;95;95;95 06:56:40 INFO - PROCESS | 3912 | |8;json-parse-financial;64;65;64;64;64;65;65;65;65;65 06:56:40 INFO - PROCESS | 3912 | |9;json-stringify-tinderbox;65;67;65;66;68;66;66;65;66;66 06:56:40 INFO - PROCESS | 3912 | |10;stanford-crypto-aes;85;83;82;82;83;93;83;82;83;83 06:56:40 INFO - PROCESS | 3912 | |11;stanford-crypto-ccm;151;138;137;137;147;141;139;152;188;146 06:56:40 INFO - PROCESS | 3912 | |12;stanford-crypto-pbkdf2;172;173;178;174;181;172;171;177;173;172 06:56:40 INFO - PROCESS | 3912 | |13;stanford-crypto-sha256-iterative;74;69;71;70;70;74;69;69;70;68 06:56:40 INFO - PROCESS | 3912 | __end_tp_report 06:56:40 INFO - PROCESS | 3912 | __start_cc_report 06:56:40 INFO - PROCESS | 3912 | _x_x_mozilla_cycle_collect,2010 06:56:40 INFO - PROCESS | 3912 | __end_cc_report 06:56:40 INFO - PROCESS | 3912 | __startTimestamp1476280600068__endTimestamp 06:56:40 INFO - PROCESS | 3912 | 06:56:40 INFO - PROCESS | 3912 | ------- Summary: start ------- 06:56:40 INFO - PROCESS | 3912 | Number of tests: 14 06:56:40 INFO - PROCESS | 3912 | 06:56:40 INFO - PROCESS | 3912 | [#0] ai-astar Cycles:10 Average:115.70 Median:116.00 stddev:1.42 (1.2%) stddev-sans-first:1.12 06:56:40 INFO - PROCESS | 3912 | Values: 113.0 115.0 117.0 116.0 116.0 118.0 115.0 115.0 117.0 115.0 06:56:40 INFO - PROCESS | 3912 | 06:56:40 INFO - PROCESS | 3912 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:135.00 stddev:15.80 (11.7%) stddev-sans-first:16.29 06:56:40 INFO - PROCESS | 3912 | Values: 151.0 131.0 126.0 169.0 138.0 132.0 132.0 129.0 166.0 131.0 06:56:40 INFO - PROCESS | 3912 | 06:56:40 INFO - PROCESS | 3912 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.01 06:56:40 INFO - PROCESS | 3912 | Values: 159.0 160.0 163.0 161.0 161.0 161.0 162.0 161.0 163.0 161.0 06:56:40 INFO - PROCESS | 3912 | 06:56:40 INFO - PROCESS | 3912 | [#3] audio-fft Cycles:10 Average:83.90 Median:76.00 stddev:16.52 (21.7%) stddev-sans-first:17.28 06:56:40 INFO - PROCESS | 3912 | Values: 76.0 76.0 77.0 122.0 77.0 75.0 76.0 76.0 107.0 77.0 06:56:40 INFO - PROCESS | 3912 | 06:56:40 INFO - PROCESS | 3912 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:84.00 stddev:21.05 (25.1%) stddev-sans-first:21.75 06:56:40 INFO - PROCESS | 3912 | Values: 83.0 83.0 134.0 84.0 84.0 84.0 119.0 84.0 84.0 127.0 06:56:40 INFO - PROCESS | 3912 | 06:56:40 INFO - PROCESS | 3912 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:1.70 (1.5%) stddev-sans-first:1.80 06:56:40 INFO - PROCESS | 3912 | Values: 117.0 122.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 06:56:40 INFO - PROCESS | 3912 | 06:56:40 INFO - PROCESS | 3912 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 06:56:40 INFO - PROCESS | 3912 | Values: 147.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 146.0 06:56:40 INFO - PROCESS | 3912 | 06:56:40 INFO - PROCESS | 3912 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:56:40 INFO - PROCESS | 3912 | Values: 95.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 06:56:40 INFO - PROCESS | 3912 | 06:56:40 INFO - PROCESS | 3912 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 06:56:40 INFO - PROCESS | 3912 | Values: 64.0 65.0 64.0 64.0 64.0 65.0 65.0 65.0 65.0 65.0 06:56:40 INFO - PROCESS | 3912 | 06:56:40 INFO - PROCESS | 3912 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.94 (1.4%) stddev-sans-first:0.93 06:56:40 INFO - PROCESS | 3912 | Values: 65.0 67.0 65.0 66.0 68.0 66.0 66.0 65.0 66.0 66.0 06:56:40 INFO - PROCESS | 3912 | 06:56:40 INFO - PROCESS | 3912 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.00 stddev:3.31 (4.0%) stddev-sans-first:3.49 06:56:40 INFO - PROCESS | 3912 | Values: 85.0 83.0 82.0 82.0 83.0 93.0 83.0 82.0 83.0 83.0 06:56:40 INFO - PROCESS | 3912 | 06:56:40 INFO - PROCESS | 3912 | [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:146.50 stddev:15.28 (10.4%) stddev-sans-first:16.15 06:56:40 INFO - PROCESS | 3912 | Values: 151.0 138.0 137.0 137.0 147.0 141.0 139.0 152.0 188.0 146.0 06:56:40 INFO - PROCESS | 3912 | 06:56:40 INFO - PROCESS | 3912 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:173.50 stddev:3.27 (1.9%) stddev-sans-first:3.36 06:56:40 INFO - PROCESS | 3912 | Values: 172.0 173.0 178.0 174.0 181.0 172.0 171.0 177.0 173.0 172.0 06:56:40 INFO - PROCESS | 3912 | 06:56:40 INFO - PROCESS | 3912 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.00 stddev:2.07 (3.0%) stddev-sans-first:1.73 06:56:40 INFO - PROCESS | 3912 | Values: 74.0 69.0 71.0 70.0 70.0 74.0 69.0 69.0 70.0 68.0 06:56:40 INFO - PROCESS | 3912 | -------- Summary: end -------- 06:56:40 INFO - PROCESS | 3912 | 06:56:41 INFO - TEST-INFO | 3912: exit 0 06:56:41 INFO - TEST-OK | kraken | took 65382ms 06:56:41 INFO - SUITE-END | took 1187s 06:56:41 INFO - Completed test suite (00:19:48) 06:56:41 INFO - javascript benchmark 06:56:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2471.3945083454555, 2519.974800251997, 2525.26767237501, 2537.06128732369, 2559.47530756195, 4326.567343265672, 4386.539413361599, 4576.0, 4578.816847326108, 4615.630749540037, 4427.09244604856, 4435.223835828725, 4437.534058923815, 4442.82228710852, 4445.91108177837, 4054.3513037913867, 4062.796860156995, 4063.4920634920636, 4063.5936406359424, 4135.110951145503, 4224.070704445033, 4253.064325848309, 4263.914721705564, 4267.871963841089, 4273.65810735142, 4228.112096459732, 4244.596763307481, 4265.7014009019385, 4266.679999000072, 4293.0, 4310.784460776948, 4312.698111132222, 4319.50325712544, 4337.891552711191, 4340.9798697306105, 4117.053077792125, 4145.067359844011, 4195.223883581547, 4231.0, 4293.806778694966, 4480.126375356806, 4505.211587972091, 4527.61515271199, 4529.230030894722, 4531.77341132942, 4799.376081109468, 4800.3279540864305, 4805.977081922993, 4832.830850920236, 4886.022795440926, 4835.661503694742, 4851.708897466128, 4853.126437241295, 4886.315915771795, 4906.582940450066, 4605.999999999966, 4621.052684199798, 4652.581267685857, 4665.0903073900945, 4714.269288260325, 5081.212412076134, 5084.949150508522, 5090.414602320707, 5092.8472145835685, 5154.768035438415, 4862.17343051682, 4869.366982292279, 4872.0, 4875.68308059975, 4934.407871055496, 4845.370101886802, 4884.462709101996, 4889.584385327216, 4943.357363542788, 4987.600991920638, 4943.456219815817, 4951.876203094951, 4996.875078123076, 5002.174641184164, 5004.574611158019, 4940.061388336205, 4947.802087916443, 4949.82675606352, 4950.628702847301, 4993.201087825931, 3806.7715937043868, 3813.1420430402936, 3846.4999550058874, 3901.765894046366, 3903.0632648164237, 3412.368711788327, 3415.351083294166, 3426.8971930842113, 3435.587729472479, 3475.2528206435736, 4295.076558539929, 4309.956900430955, 4317.222899878052, 4338.717983331137, 4359.934600980988, 4841.661083724105, 4935.161022626162, 4946.579540739005, 4948.554630083309, 5005.74971251436, 4245.575442455792, 4270.039241170712, 4282.764447955392, 4291.120320334324, 4294.162638285567, 4414.161309351213, 4418.270985287456, 4428.114377124523, 4448.844290449819, 4479.238529450001, 4670.462896766915, 4677.929831052469, 4677.976610116995, 4684.48470668233, 4739.146953548395, 4839.128956787812, 4879.634027447884, 4891.19295316283, 4921.606271498343, 4942.555170034714, 4653.767311634337, 4666.066786642617, 4690.530946905282, 4698.647601429975, 4740.597049250714, 4868.732219727949, 4871.34236878017, 4883.243097319921, 4924.113659541317, 4927.507249275044, 4878.80484780619, 4929.457759646364, 4933.6299777516115, 4943.555080042814, 4982.377202849644, 4684.0866031123605, 4727.929081063856, 4781.904361912672, 4820.867096232453, 4865.978144589534, 4782.52174782519, 4794.328793968777, 4807.759612019455, 4815.7351345676325, 4838.879028024327, 4699.107169637758, 4750.928736068892, 4763.857084287477, 4764.737939413366, 4765.213739732905, 4721.055788842176, 4770.356001939833, 4848.684835485682, 4864.36763220779, 4930.038642464829, 4691.249400095969, 4691.272852707836, 4720.740359280273, 4724.173269677862, 4783.354247176587], "value": 4495.499649499487, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.312371097983, 564.2101058518075, 565.2538648983343, 568.8805350876315, 573.6013470637909, 26200.2139935802, 26674.33314167147, 37946.430803537936, 38849.417258741145, 38902.416463753, 39971.40042899352, 40039.19921601566, 40055.198896022135, 40072.39891401631, 40082.39876401849, 7612.200718924516, 7760.961195194044, 7763.184865589116, 7764.767056988271, 7769.533827970312, 7615.048118985127, 7693.846123077535, 7703.691852325928, 7704.730334438295, 7707.267809558083, 7691.961540192319, 7724.536527808349, 7729.652165652531, 7739.845203095934, 7751.728689495869, 7646.885296720554, 7688.500247483896, 7692.923070769277, 7708.421868359839, 7749.612519374009, 7653.043369578802, 7718.53688778675, 7718.768436946901, 7720.53676779395, 7721.65252563636, 37572.81213593942, 37895.0, 37923.241535169145, 38050.80974595109, 38057.23885522302, 2835.758960488361, 3015.175321704903, 3143.6227652681823, 3450.551428314303, 3524.5770507539005, 27353.863230683917, 27509.44981100367, 27689.86155069232, 28474.71525284762, 28782.0, 3283.8850640227715, 3381.1040074380307, 3383.3571621392102, 3428.142964258935, 3462.515247865301, 252832.0, 253142.0, 253640.0, 254666.0, 255592.72203639048, 31216.531752023737, 53089.2036619451, 53437.1984420234, 53524.464755352725, 53548.0, 33496.66503334984, 33527.832360838525, 33638.0, 33718.15704607405, 33755.0, 13346.866531334757, 13512.108304837331, 13513.121647092907, 13514.32428378577, 13523.0, 10444.63443779464, 10445.216608754374, 10447.94776026115, 10451.059404653617, 10456.424896630606, 7628.313451789255, 7742.148363680103, 7816.68733250675, 7836.882446763303, 7848.0974687910475, 3036.4686179918426, 3082.5838511801066, 3092.3196896682693, 3137.576427182347, 3145.308032232905, 842.806154584449, 900.3157600223747, 944.15026476172, 979.1041197304387, 993.3245393132595, 26288.8685556571, 26563.335916601853, 27327.45345093087, 27531.449371012466, 27536.17391478259, 949.8337790886567, 984.5963155106372, 1000.8748906386702, 1004.1665417703289, 1047.2302857399804, 13716.177029378268, 14229.14625122496, 14329.211893345757, 14616.0198183321, 14701.191434471206, 345858.0, 348480.0, 348503.0, 349066.0, 349423.0, 47439.52560474351, 47902.5209747905, 47906.281405778944, 47958.28062579064, 47988.520114798404, 1139.1342579639368, 1160.843286156375, 1174.518447436547, 1179.9557391708229, 1195.9162858599814, 25406.237812865642, 26310.736892631594, 26652.60021099724, 27173.59239611447, 27233.455330892873, 40482.39276410915, 40796.0, 40879.1824163521, 40900.386494202015, 40959.38560921648, 243274.0, 244171.0, 244415.0, 244475.0, 245119.0, 24605.87697061503, 24677.753222467545, 24800.50398992046, 25073.0, 25085.498290034462, 40245.79877100596, 43918.34122488229, 44101.77949110234, 44770.0, 44810.55189448064, 34638.30723385569, 34762.0, 34923.65076349204, 35426.64573354233, 35513.0, 35092.64907350894, 35134.47298290579, 35394.29211415809, 35903.0, 35965.28069438649, 34401.31197375988, 34752.304953900275, 35137.29725405529, 35145.970805839446, 35652.46521302235, 30571.388572228876, 32683.34633307368, 32714.509282360308, 32801.50797738084, 32895.177620559676, 24534.754652453248, 24928.875355623106, 25036.874815625804, 25169.622455662815, 25420.364490887874], "value": 16034.24988297419, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.86269198282713, 339.45347989736536, 358.70765326259107, 360.25607121294524, 376.59892214791245, 11980.161388702783, 13005.089643724943, 15503.612409689764, 15913.44302949397, 16098.0, 16344.509664710047, 16592.0, 16792.66414671706, 16881.0, 16934.661306773858, 4486.753228572427, 4850.87872803181, 5056.241563765446, 5062.607782859706, 5070.771815268304, 5869.383714709937, 6004.09938509225, 6050.818475445743, 6068.514518838504, 6070.0, 5828.591998560102, 5995.490383317423, 6014.488768454687, 6015.398460153971, 6037.184980027684, 5944.851378715523, 5972.6715030673295, 5981.132735753292, 5981.790637327695, 5984.521238300926, 4640.65195110368, 4889.973105647819, 4906.779194936201, 4918.065567542156, 5236.450172731885, 11940.343281119534, 12149.574764883188, 12211.206271592408, 13131.474741010348, 19401.32095376669, 1752.2465339903836, 1886.1700851625242, 1930.2664987304875, 2076.7404074490687, 2184.726909136358, 9192.0, 9647.855282170773, 9654.517274136335, 11110.888891111146, 12964.87035129646, 1626.9267882945296, 1692.5514738594159, 1701.5150682055678, 1720.320473412995, 1733.0554847608084, 67510.0, 68668.31331686719, 70773.2922670777, 70862.2913770866, 74111.0, 8076.2540736149995, 8323.750287491384, 8663.78340541479, 8764.0, 9479.668211612698, 10783.191260655482, 10847.403392813314, 10865.891341086646, 10872.45637718111, 10893.128549716004, 6313.779017734358, 6437.742490300336, 6494.220693516808, 6512.283648798629, 6549.803505894831, 6424.357564243538, 6486.091947127406, 6597.703103360361, 6659.800205993828, 6718.294579069127, 3230.709236168756, 3314.4034073866455, 3397.235621985083, 3403.353362861098, 3420.8973730788116, 1657.2790835986384, 1659.8174200837898, 1686.8819182657342, 1729.1008775211817, 1757.9648407031789, 776.5185584937375, 826.3760860550246, 853.4282031039095, 875.3959767760225, 892.5775911338644, 16142.919285403732, 16849.241784119746, 17168.914155429142, 17292.0, 17338.826611733723, 792.4056957282038, 819.4509678515409, 823.9752807415787, 838.8322335532918, 877.4998250996998, 8929.508877011827, 8970.955145224232, 9071.27429805614, 9096.81806363869, 9360.485173315397, 336307.0, 356125.0, 369826.0, 370766.0, 375769.36345954833, 77683.34749787577, 79299.60350198211, 79544.60227698824, 80800.0, 81310.59344703356, 850.4812064640564, 874.2132081127037, 877.8244351129672, 878.5168157513469, 885.274075258282, 14261.714765704835, 14391.784123238369, 14546.418143274574, 14741.410343586136, 15180.0, 37781.81109094547, 37940.241195176495, 38050.80974595109, 38584.42123368096, 38977.76355783174, 50423.0, 51219.0, 52000.57995070461, 52032.219516708035, 52937.0, 7044.260352663102, 7161.713531458683, 7709.2290770922455, 7755.2244775521995, 8064.83870322602, 10775.137988961022, 10928.071113955402, 11172.776544469227, 11270.267432616854, 11319.603813866475, 9018.774530636787, 9628.855567166638, 9716.0, 9862.506874656096, 10029.197664186993, 8768.605412756313, 9679.128878400978, 9725.31922765428, 9921.454320012468, 10318.329308594917, 8942.552872356486, 9507.191888689262, 9689.370190937567, 9989.700308990741, 10346.0, 7015.298470152944, 7167.820804479929, 7299.671514781954, 7315.451341149329, 7423.146338171179, 7840.921590784247, 9629.229661626912, 9847.753806154904, 9912.603495860374, 10031.799364012533], "value": 7816.941285076572, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1151.2862025544164, 1324.1657755613965, 1356.3218390804598, 1410.7742761158217, 1645.169189559273, 6335.176427064481, 6919.757808476698, 7202.963985180067, 7208.135023797146, 7395.889061664079, 7297.781066568012, 7348.2284360142085, 7354.227806080365, 7360.227176146508, 7368.042154519918, 2059.6601560742497, 2063.432556047084, 2084.4267826347723, 2087.436392174112, 2089.8955052247325, 2035.5114772454579, 2055.43475544225, 2062.2369723202437, 2103.3479621317365, 2103.684447332897, 1970.6945423459315, 2017.4149496645955, 2028.9391318260402, 2031.8476114291414, 2032.0550943811124, 2006.0872303102126, 2013.577148798754, 2014.6776515757556, 2015.586804705032, 2018.041430320586, 2009.9799002009938, 2023.2716222160159, 2053.712480252766, 2055.085486958304, 2060.1450398084776, 7261.0, 7273.236310187407, 7339.77980660581, 7429.925700742978, 7431.628418579049, 4373.803178856959, 4500.819967201308, 4503.752293623849, 4504.684672072956, 4524.8190072397065, 2682.0746842339363, 2789.623400840881, 2842.161562339115, 2842.6020357150014, 2847.330877243846, 892.7678803511069, 894.4901406198469, 897.7710683775596, 907.7503686486203, 908.3051465628733, 9914.80170396588, 10004.149647279917, 10042.196624269967, 10049.296549241555, 10057.346272492265, 3744.8689295874515, 3776.8489260429274, 3948.4274780156716, 3961.841526338972, 3979.383195604686, 7854.764357069297, 7901.565413902291, 7902.723404680809, 7930.048394192619, 7933.325667318227, 4250.659947204216, 4256.7445953242905, 4257.893552661209, 4260.062786187096, 4265.296226122655, 3569.5538057742783, 3660.908477288036, 3830.0807806126327, 3946.7039972002217, 3952.071263253133, 3179.825109618947, 3189.649138594753, 3234.2884565395575, 3237.482002879528, 3363.613184483767, 980.7352014955922, 991.3655260633201, 1015.8577799108131, 1028.2596530498179, 1033.0186322993186, 595.9314678811992, 640.0015975078799, 685.1880521581942, 712.6828561290176, 718.2637796258772, 4586.3579098926175, 4724.551167639069, 4741.95258047422, 4749.857504274877, 5089.4147173074825, 388.46391979069267, 397.6917888636272, 403.9333509970822, 406.87183537185695, 410.8787907567275, 3215.903522894317, 3220.66183050781, 3225.177579717204, 3242.2218667519624, 3318.253392986607, 8190.7952301192945, 8568.143185681382, 8690.217880390795, 8796.120387961153, 8803.031666516677, 8552.144785521397, 8756.168164024408, 8759.912400876037, 8776.385653004356, 8781.990071141772, 6663.300353462913, 6729.730810767514, 6733.158355205599, 6737.59574425536, 6748.865022699617, 4681.695689780154, 4728.267118596623, 4731.384919960383, 4879.902401952012, 4918.0, 8013.3589312856, 8042.316403105568, 8305.127961563949, 8326.791830204293, 8342.749717508485, 8290.253877151084, 8337.416380853281, 8386.454880432751, 8450.450720703135, 8463.195996380335, 5774.913376299275, 6459.741610335534, 6594.208694956444, 6597.80206593803, 6609.1408116944485, 6386.946153884557, 6752.696128674123, 6999.440044796303, 7004.824879378057, 7258.0, 6449.419552240133, 6465.741370345134, 6493.902591461227, 6525.0538671893255, 6617.305182955913, 6213.782517611862, 6298.653574053471, 6347.587406818542, 6561.901571476336, 6644.335566443317, 5866.5893387462465, 5992.4307190818545, 5994.340622531605, 5995.160677505066, 6006.429389208019, 4201.831926722897, 4273.41933175647, 4326.242907491113, 4379.978100109479, 4455.866324010285, 4259.488861336659, 4276.87169384919, 4317.330813723878, 4458.621017213443, 4474.463064432289], "value": 3756.6550330239716, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.12321433911853, 285.3963866422516, 294.2349890285257, 304.4702218140436, 307.39750089823946, 4828.372311599492, 4845.927311090328, 4878.926816097762, 4879.585235254999, 4884.340614017106, 4525.932111018337, 4612.33121197427, 4681.602063824579, 4738.6355687461855, 4803.327534145223, 3763.962360376402, 3769.6795772359383, 3775.9811200943955, 3786.1481166737403, 3804.7907365094907, 3767.6420740029653, 3788.5074940257728, 3796.7152463565203, 3830.578636349999, 3831.7355272759924, 3532.717382609398, 3555.004598712365, 3672.981635091821, 3761.8119094045323, 3762.43563465481, 3743.6630703236565, 3752.43713442983, 3754.3805272130066, 3756.286305601927, 3758.849646014156, 3336.5996080470254, 3341.732661387083, 3345.916352091193, 3347.8493467794005, 3353.0779035765117, 4458.732476051415, 4710.0, 4715.3634259374885, 4717.127331443694, 4729.621630269605, 4238.597333253336, 4253.447051883235, 4272.743635381856, 4273.764942928137, 4282.614564689162, 5035.345405097314, 5040.092783299005, 5047.798088076473, 5049.368828896388, 5104.591632669415, 3588.946165807515, 3593.425051991695, 3595.8741444049333, 3598.5321908152036, 3603.8738644147593, 5160.938352427706, 5198.740062996872, 5223.425423203445, 5224.760648398017, 5240.423553409122, 3638.235970446183, 3639.5259919732553, 3646.507721457622, 3653.397189463709, 3669.211119609297, 3713.665770080706, 3717.3308804414924, 3724.7522080102926, 3726.888193354204, 3762.8682996095004, 4170.436991006236, 4275.700700950903, 4290.549492303326, 4291.69958102936, 4294.720843145185, 4997.85006449807, 5006.324146240284, 5006.924896126561, 5008.899822003539, 5013.5989120870245, 1265.9240445573296, 1281.333706472629, 1282.58316047285, 1283.6726634708089, 1287.9310172556943, 808.5754978636263, 816.2082779703796, 828.3331917806104, 839.7354833227514, 842.5281842168405, 4398.934015989763, 4452.354408610733, 4517.232070547949, 4537.342085397599, 4548.522405147478, 5170.353705786777, 5177.223416487482, 5177.508136727005, 5178.559822415062, 5182.144946083929, 4343.1530851484285, 4517.531802164244, 4522.592966632953, 4557.313793896214, 4565.543445655474, 2741.3420779012895, 2769.0, 2769.407590635393, 2780.958285625717, 2783.5546312590295, 4885.682430641997, 4912.771807048238, 4915.21356582945, 4940.580050695731, 4946.318251794407, 4991.875203119951, 5211.296474975906, 5242.580593552507, 5278.762455689426, 5289.603279754034, 4871.318015477836, 4872.9512704872495, 4886.584640305543, 4894.877628059327, 4901.0, 5101.69389836611, 5104.9489505104475, 5111.156659151347, 5117.565006974449, 5135.435102138687, 4897.219159622688, 4903.019396120719, 5012.974935125447, 5030.798768049237, 5072.691925173963, 4893.531940417789, 4899.755012249445, 4902.362692849907, 4912.92630610534, 4916.70499770015, 3582.4743555792584, 3590.7666001709804, 3595.424732042861, 3608.530890984155, 3614.367485690046, 4977.0, 5118.309028281284, 5138.563222126161, 5149.201873709581, 5157.535821776059, 5001.42483614389, 5004.024215277986, 5004.674696144739, 5007.47421520735, 5024.924626130538, 4994.475580064186, 4997.85006449807, 5002.374703162105, 5003.474635163256, 5026.170681837456, 4698.271767875985, 4902.313676085422, 4937.851864444073, 4939.629527785359, 4956.430010548689, 4805.687630304019, 4885.5358740919555, 4929.876753081202, 5001.64988450805, 5014.147594908802, 4929.4225847728385, 4937.851864444073, 4966.652334336562, 4967.776450059829, 4985.725785081855], "value": 3783.974631005161, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.3095892052775, 572.1674962928939, 584.0217635460602, 589.1133843565433, 598.8712426828231, 11941.701457463569, 12748.617541473748, 13072.281024543647, 13107.213567185963, 13933.372998215105, 11765.588204412847, 11881.227720198181, 11888.583899563517, 11899.702507437296, 11912.225705329169, 545.9563234941215, 731.3746746531718, 755.7808235611666, 761.801931497809, 762.6491813765674, 561.1078385367285, 724.4566575068699, 745.1356426545209, 751.4176513202258, 751.9622920369909, 794.5947566740975, 796.80079980005, 797.5693125712138, 797.6649807081011, 797.7447216890597, 564.7289301135437, 788.5071830106184, 790.0519376747925, 790.2097902097902, 791.1692722641233, 424.21520187652595, 558.4638746803074, 573.2919843992707, 576.7548791763526, 577.9219805326269, 11906.821397679041, 11954.163208575403, 11958.402079896057, 11959.461824217931, 11997.520099196021, 11473.827892581618, 12416.423134176091, 12561.183523071062, 12579.964763393651, 12610.936945315214, 11669.241499302518, 11695.766084678344, 11776.293422394683, 11783.410829458579, 11952.099639147908, 3176.745860331168, 3188.601424821897, 3290.2596915694016, 4054.9391759123637, 4122.2786012447705, 57617.0, 58235.41764582384, 58271.0, 59181.40818591802, 59444.70277648627, 9688.951555242178, 9796.118349348593, 9851.0, 9890.159336456338, 9987.550560224807, 17285.827141728423, 17444.5638859027, 17452.650946981244, 17493.0, 17531.123443827757, 5907.556933230025, 6009.06859436788, 6095.3904609538695, 6203.379662033851, 6286.874262514724, 3164.3354895472207, 3392.5759280089987, 3416.6754158354915, 3450.7584469087424, 3485.4771784232566, 2727.7272272772566, 3045.680203578637, 3221.855016524262, 3224.98412999909, 3225.8064516129107, 522.3888050980362, 526.8156145349097, 529.3145376737135, 529.9533421492522, 534.1053734993869, 384.8018270590648, 495.805109685663, 530.9283246761715, 539.1185411851573, 569.6752850875044, 7095.50331476802, 7241.2396698346965, 7855.3187676408015, 7918.920810791818, 7931.484453510503, 452.94791099024036, 460.6084827896261, 529.534010071135, 554.3403350013471, 589.1898639370866, 3606.531150950412, 3835.194609132058, 3952.1700442906736, 3975.383815508601, 4027.154297597479, 50875.236871446956, 51263.7436812821, 94694.0, 96206.0, 99641.0, 62165.0, 84419.57790211009, 84893.0, 85643.0, 86861.0, 69893.65053174803, 70455.2954470459, 70593.29406705867, 70829.64585177042, 75168.0, 7300.744473943387, 7381.704731810667, 7441.962790186014, 7553.584552849646, 7622.771316860503, 42571.574284258, 44259.77870110629, 45393.773031135956, 45473.0, 45805.77097114493, 35333.46999795057, 35507.82246088753, 55309.170362443794, 56325.43674563202, 58297.0, 11188.272762270752, 11216.158788091088, 11325.830112548483, 11571.0, 11706.590269340531, 12323.0, 12584.433700483318, 13003.154794938298, 13436.731265374834, 13565.728685426038, 11247.493862776359, 11265.0, 11445.25605835618, 11481.36852473122, 11726.355050472306, 10186.898131018595, 11563.6530904073, 11633.418329083343, 12044.879551204376, 12049.397530123633, 10739.946300268448, 11282.830757538479, 11374.488148033193, 12022.879771202526, 12128.75742485163, 9594.616215351307, 9912.058354456316, 10114.443705595968, 10246.743831404274, 10403.167746580104, 9545.522723863918, 9553.665621703207, 9607.004199350356, 9669.758256043655, 10220.02057387129], "value": 6219.4508361592125, "unit": "score"}], "name": "dromaeo_css", "value": 6066.001102168352, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 117.0, 116.0, 116.0, 118.0, 115.0, 115.0, 117.0, 115.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 131.0, 126.0, 169.0, 138.0, 132.0, 132.0, 129.0, 166.0, 131.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 163.0, 161.0, 161.0, 161.0, 162.0, 161.0, 163.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 122.0, 77.0, 75.0, 76.0, 76.0, 107.0, 77.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 134.0, 84.0, 84.0, 84.0, 119.0, 84.0, 84.0, 127.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 122.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 66.0, 68.0, 66.0, 66.0, 65.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 82.0, 82.0, 83.0, 93.0, 83.0, 82.0, 83.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 138.0, 137.0, 137.0, 147.0, 141.0, 139.0, 152.0, 188.0, 146.0], "value": 147.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 178.0, 174.0, 181.0, 172.0, 171.0, 177.0, 173.0, 172.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 69.0, 71.0, 70.0, 70.0, 74.0, 69.0, 69.0, 70.0, 68.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1564.1000000000001, "alertThreshold": 2.0}]} 06:56:41 INFO - Return code: 0 06:56:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:56:41 INFO - # TBPL SUCCESS # 06:56:41 INFO - Running post-action listener: _resource_record_post_action 06:56:41 INFO - [mozharness: 2016-10-12 13:56:41.850873Z] Finished run-tests step (success) 06:56:41 INFO - Running post-run listener: _resource_record_post_run 06:56:41 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 12288; Write bytes: 392187904; Read time: 236; Write time: 272036 06:56:41 INFO - TinderboxPrint: CPU usage
13.0% 06:56:41 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 236 06:56:41 INFO - TinderboxPrint: I/O write bytes / time
392,187,904 / 272,036 06:56:41 INFO - TinderboxPrint: CPU idle
8,355.6 (87.0%) 06:56:41 INFO - TinderboxPrint: CPU user
1,203.1 (12.5%) 06:56:41 INFO - TinderboxPrint: Swap in / out
0 / 0 06:56:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 99352576; Read time: 160; Write time: 64684 06:56:41 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292835328; Read time: 72; Write time: 207352 06:56:42 INFO - Running post-run listener: _upload_blobber_files 06:56:42 INFO - Blob upload gear active. 06:56:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:56:42 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 06:56:42 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', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:56:42 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 Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:56:42 INFO - (blobuploader) - INFO - Open directory for files ... 06:56:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:56:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:56:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:43 INFO - (blobuploader) - INFO - Done attempting. 06:56:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:56:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:56:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:47 INFO - (blobuploader) - INFO - Done attempting. 06:56:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:56:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:56:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:47 INFO - (blobuploader) - INFO - Done attempting. 06:56:47 INFO - (blobuploader) - INFO - Iteration through files over. 06:56:47 INFO - Return code: 0 06:56:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:56:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:56:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/3ef9da2f4824bec312f6ca93c5064c6ef81f26758762b63abe65d11e9f65cf91c124ec7131711f22060ab56c3715df503635ee75a45af27d0b8714f351569d88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/c6fe43b60f222239034021de91cb10e80dfb49c30ba005717c7c286e4afbeba48f3e58e60048595072058b9a6cb912934e6534040fb28b5c6dd23c13cdfa14f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/aa1b8e9d3890c080cf8eba7870db4febaf14143397b4227bae271a13ab1882aef336896a58924981c12a5569105f80f2b97f00ce9e8b8b8ed992f9d4ac7a7b19"} 06:56:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:56:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:56:47 INFO - Contents: 06:56:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/3ef9da2f4824bec312f6ca93c5064c6ef81f26758762b63abe65d11e9f65cf91c124ec7131711f22060ab56c3715df503635ee75a45af27d0b8714f351569d88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/c6fe43b60f222239034021de91cb10e80dfb49c30ba005717c7c286e4afbeba48f3e58e60048595072058b9a6cb912934e6534040fb28b5c6dd23c13cdfa14f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/aa1b8e9d3890c080cf8eba7870db4febaf14143397b4227bae271a13ab1882aef336896a58924981c12a5569105f80f2b97f00ce9e8b8b8ed992f9d4ac7a7b19"} 06:56:47 INFO - Running post-run listener: copy_logs_to_upload_dir 06:56:47 INFO - Copying logs to upload dir... 06:56:47 INFO - mkdir: /builds/slave/test/build/upload/logs 06:56:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.642027 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-12 06:56:47.564984) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 06:56:47.570582) ========= 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=4300f881736b422476174874000001bc-1476274921.318071-923543322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/3ef9da2f4824bec312f6ca93c5064c6ef81f26758762b63abe65d11e9f65cf91c124ec7131711f22060ab56c3715df503635ee75a45af27d0b8714f351569d88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/c6fe43b60f222239034021de91cb10e80dfb49c30ba005717c7c286e4afbeba48f3e58e60048595072058b9a6cb912934e6534040fb28b5c6dd23c13cdfa14f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/aa1b8e9d3890c080cf8eba7870db4febaf14143397b4227bae271a13ab1882aef336896a58924981c12a5569105f80f2b97f00ce9e8b8b8ed992f9d4ac7a7b19"} build_url:https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011524 build_url: 'https://queue.taskcluster.net/v1/task/JIOAjBUfSu2_bx76S1H0UA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/3ef9da2f4824bec312f6ca93c5064c6ef81f26758762b63abe65d11e9f65cf91c124ec7131711f22060ab56c3715df503635ee75a45af27d0b8714f351569d88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/c6fe43b60f222239034021de91cb10e80dfb49c30ba005717c7c286e4afbeba48f3e58e60048595072058b9a6cb912934e6534040fb28b5c6dd23c13cdfa14f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/aa1b8e9d3890c080cf8eba7870db4febaf14143397b4227bae271a13ab1882aef336896a58924981c12a5569105f80f2b97f00ce9e8b8b8ed992f9d4ac7a7b19"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 06:56:47.599170) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:56:47.599535) ========= 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=4300f881736b422476174874000001bc-1476274921.318071-923543322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:56:47.678915) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 06:56:47.682294) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 06:56:47.682606) ========= ========= Total master_lag: 0.21 =========