builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1476944803.73 results: success (0) buildid: 20161019204247 builduid: e07323037d1f4e70a79800504e48a50a revision: cc5d68a2fcf8f2344f5f46595d8f1194c286a9c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 23:26:43.730000) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 23:26:43.730494) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 23:26:43.730808) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 23:26:43.779485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 23:26:43.779845) ========= 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=db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-19 23:26:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 2.69M=0.004s 2016-10-19 23:26:44 (2.69 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084145 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 23:26:43.888145) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 23:26:43.888438) ========= 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=db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017755 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 23:26:43.940270) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 23:26:43.940686) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev cc5d68a2fcf8f2344f5f46595d8f1194c286a9c7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev cc5d68a2fcf8f2344f5f46595d8f1194c286a9c7 --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=db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-19 23:26:44,152 truncating revision to first 12 chars 2016-10-19 23:26:44,152 Setting DEBUG logging. 2016-10-19 23:26:44,152 attempt 1/10 2016-10-19 23:26:44,152 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/cc5d68a2fcf8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 23:26:45,419 unpacking tar archive at: autoland-cc5d68a2fcf8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.578898 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 23:26:45.632202) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 23:26:45.632603) ========= script_repo_revision: cc5d68a2fcf8f2344f5f46595d8f1194c286a9c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 23:26:45.633044) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 23:26:45.633320) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 23:26:45.643987) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-19 23:26:45.644370) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:26:45 INFO - MultiFileLogger online at 20161019 23:26:45 in /builds/slave/test 23:26:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 23:26:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:26:45 INFO - {'append_to_log': False, 23:26:45 INFO - 'base_work_dir': '/builds/slave/test', 23:26:45 INFO - 'blob_upload_branch': 'Autoland', 23:26:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:26:45 INFO - 'branch': 'Autoland', 23:26:45 INFO - 'buildbot_json_path': 'buildprops.json', 23:26:45 INFO - 'config_files': ('talos/linux_config.py',), 23:26:45 INFO - 'default_actions': ('clobber', 23:26:45 INFO - 'read-buildbot-config', 23:26:45 INFO - 'download-and-extract', 23:26:45 INFO - 'populate-webroot', 23:26:45 INFO - 'create-virtualenv', 23:26:45 INFO - 'install', 23:26:45 INFO - 'run-tests'), 23:26:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:26:45 INFO - 'download_minidump_stackwalk': True, 23:26:45 INFO - 'download_symbols': 'ondemand', 23:26:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:26:45 INFO - 'tooltool.py': '/tools/tooltool.py', 23:26:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:26:45 INFO - '/tools/misc-python/virtualenv.py')}, 23:26:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:26:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:26:45 INFO - 'installer_path': 'installer.exe', 23:26:45 INFO - 'log_level': 'info', 23:26:45 INFO - 'log_name': 'talos', 23:26:45 INFO - 'log_to_console': True, 23:26:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:26:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:26:45 INFO - 'opt_config_files': (), 23:26:45 INFO - 'pip_index': False, 23:26:45 INFO - 'sps_profile': False, 23:26:45 INFO - 'sps_profile_interval': 0, 23:26:45 INFO - 'suite': 'dromaeojs-e10s', 23:26:45 INFO - 'system_bits': '32', 23:26:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:26:45 INFO - 'title': 'talos-linux64-ix-049', 23:26:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:26:45 INFO - 'use_talos_json': True, 23:26:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:26:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:26:45 INFO - 'work_dir': 'build'} 23:26:45 INFO - [mozharness: 2016-10-20 06:26:45.955438Z] Running clobber step. 23:26:45 INFO - Running pre-action listener: _resource_record_pre_action 23:26:45 INFO - Running main action method: clobber 23:26:45 INFO - rmtree: /builds/slave/test/build 23:26:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:26:46 INFO - Running post-action listener: _resource_record_post_action 23:26:46 INFO - [mozharness: 2016-10-20 06:26:46.426515Z] Finished clobber step (success) 23:26:46 INFO - [mozharness: 2016-10-20 06:26:46.426618Z] Running read-buildbot-config step. 23:26:46 INFO - Running pre-action listener: _resource_record_pre_action 23:26:46 INFO - Running main action method: read_buildbot_config 23:26:46 INFO - Using buildbot properties: 23:26:46 INFO - { 23:26:46 INFO - "project": "", 23:26:46 INFO - "product": "firefox", 23:26:46 INFO - "script_repo_revision": "production", 23:26:46 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 23:26:46 INFO - "repository": "", 23:26:46 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 23:26:46 INFO - "buildid": "20161019204247", 23:26:46 INFO - "pgo_build": "True", 23:26:46 INFO - "basedir": "/builds/slave/test", 23:26:46 INFO - "buildnumber": 421, 23:26:46 INFO - "slavename": "talos-linux64-ix-049", 23:26:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:26:46 INFO - "platform": "ubuntu64_hw", 23:26:46 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 23:26:46 INFO - "branch": "autoland", 23:26:46 INFO - "repo_path": "integration/autoland", 23:26:46 INFO - "revision": "cc5d68a2fcf8f2344f5f46595d8f1194c286a9c7", 23:26:46 INFO - "stage_platform": "linux64-pgo", 23:26:46 INFO - "builduid": "e07323037d1f4e70a79800504e48a50a", 23:26:46 INFO - "slavebuilddir": "test" 23:26:46 INFO - } 23:26:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 23:26:46 INFO - Running post-action listener: _resource_record_post_action 23:26:46 INFO - [mozharness: 2016-10-20 06:26:46.429083Z] Finished read-buildbot-config step (success) 23:26:46 INFO - [mozharness: 2016-10-20 06:26:46.429173Z] Running download-and-extract step. 23:26:46 INFO - Running pre-action listener: _resource_record_pre_action 23:26:46 INFO - Running main action method: download_and_extract 23:26:46 INFO - mkdir: /builds/slave/test/build/tests 23:26:46 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')]} 23:26:46 INFO - trying https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:26:46 INFO - Downloading https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/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 23:26:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/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 23:26:46 INFO - Downloaded 1361 bytes. 23:26:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:26:46 INFO - Using the following test package requirements: 23:26:46 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:26:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:26:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:26:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:26:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:26:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:26:46 INFO - u'jsshell-linux-x86_64.zip'], 23:26:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:26:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:26:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:26:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:26:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:26:46 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:26:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:26:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:26:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:26:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:26:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:26:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:26:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:26:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:26:46 INFO - Fetch https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:26:47 INFO - Http code: 200 23:26:47 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 23:26:47 INFO - x-amz-cf-id: RWAGOCJKLeuF7Dz89GIu1csB5jGZOxNMbR1c7jl0Pcg1GKXQTQ0EIg== 23:26:47 INFO - x-amz-version-id: ExqX.S0g.hTyRdqkJ6Nx__UeOvR5I9mX 23:26:47 INFO - Expected file size: 22116905 23:26:47 INFO - Obtained file size: 22116905 23:26:52 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 23:26:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:26:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:26:52 INFO - Fetch https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:26:52 INFO - Http code: 200 23:26:52 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 23:26:52 INFO - x-amz-cf-id: 1I7i5fYFMPueFGvPhL0yUN3gqVHZHt0rC-FbQCOyS3GXhJ5wBMYweg== 23:26:52 INFO - x-amz-version-id: ExqX.S0g.hTyRdqkJ6Nx__UeOvR5I9mX 23:26:53 INFO - Expected file size: 22116905 23:26:53 INFO - Obtained file size: 22116905 23:26:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 23:26:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:26:57 INFO - Fetch https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 23:26:58 INFO - Http code: 200 23:26:58 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 23:26:58 INFO - x-amz-cf-id: OR4jb0wrLDchoo0lJElXUoqD0uMZKsK7l-W1wqr23-rVX-TTs_b1rw== 23:26:58 INFO - x-amz-version-id: 2rFTG0LcSlBwUgxPGvuVBOM2gWXGz2a3 23:26:58 INFO - Expected file size: 14409028 23:26:58 INFO - Obtained file size: 14409028 23:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:26:59 INFO - trying https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:26:59 INFO - Downloading https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/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 23:26:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/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 23:27:01 INFO - Downloaded 59489860 bytes. 23:27:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:27:01 INFO - mkdir: /builds/slave/test/properties 23:27:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:27:01 INFO - Writing to file /builds/slave/test/properties/build_url 23:27:01 INFO - Contents: 23:27:01 INFO - build_url:https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:27:02 INFO - Running post-action listener: _resource_record_post_action 23:27:02 INFO - Running post-action listener: set_extra_try_arguments 23:27:02 INFO - [mozharness: 2016-10-20 06:27:02.564713Z] Finished download-and-extract step (success) 23:27:02 INFO - [mozharness: 2016-10-20 06:27:02.564942Z] Running populate-webroot step. 23:27:02 INFO - Running pre-action listener: _resource_record_pre_action 23:27:02 INFO - Running main action method: populate_webroot 23:27:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:27:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:27:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:27:02 INFO - '--tppagecycles', 23:27:02 INFO - '7'], 23:27:02 INFO - 'tests': ['tsvgm']}}, 23:27:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:27:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:27:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:27:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:27:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:27:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:27:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:02 INFO - 'talos_options': ['--disable-e10s'], 23:27:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:27:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:27:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:02 INFO - 'talos_options': ['--disable-e10s'], 23:27:02 INFO - 'tests': ['damp', 'tps']}, 23:27:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:02 INFO - 'tests': ['damp', 'tps']}, 23:27:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:27:02 INFO - 'tests': ['dromaeo_dom']}, 23:27:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:27:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:27:02 INFO - 'tests': ['basic_compositor_video']}, 23:27:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:27:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:27:02 INFO - 'tests': ['a11yr', 23:27:02 INFO - 'ts_paint', 23:27:02 INFO - 'tpaint', 23:27:02 INFO - 'sessionrestore', 23:27:02 INFO - 'sessionrestore_no_auto_restore', 23:27:02 INFO - 'tabpaint']}, 23:27:02 INFO - 'other-e10s': {'tests': ['a11yr', 23:27:02 INFO - 'ts_paint', 23:27:02 INFO - 'tpaint', 23:27:02 INFO - 'sessionrestore', 23:27:02 INFO - 'sessionrestore_no_auto_restore', 23:27:02 INFO - 'tabpaint']}, 23:27:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:27:02 INFO - 'ts_paint', 23:27:02 INFO - 'tpaint', 23:27:02 INFO - 'sessionrestore', 23:27:02 INFO - 'sessionrestore_no_auto_restore', 23:27:02 INFO - 'tabpaint']}, 23:27:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:27:02 INFO - 'ts_paint', 23:27:02 INFO - 'tpaint', 23:27:02 INFO - 'sessionrestore', 23:27:02 INFO - 'sessionrestore_no_auto_restore', 23:27:02 INFO - 'tabpaint']}, 23:27:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:27:02 INFO - 'tests': ['a11yr', 23:27:02 INFO - 'ts_paint', 23:27:02 INFO - 'tpaint', 23:27:02 INFO - 'sessionrestore', 23:27:02 INFO - 'sessionrestore_no_auto_restore', 23:27:02 INFO - 'tabpaint']}, 23:27:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:27:02 INFO - 'tests': ['a11yr', 23:27:02 INFO - 'ts_paint', 23:27:02 INFO - 'tpaint', 23:27:02 INFO - 'sessionrestore', 23:27:02 INFO - 'sessionrestore_no_auto_restore', 23:27:02 INFO - 'tabpaint']}, 23:27:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:27:02 INFO - 'tests': ['tsvgx', 23:27:02 INFO - 'tsvgr_opacity', 23:27:02 INFO - 'tart', 23:27:02 INFO - 'tscrollx', 23:27:02 INFO - 'cart']}, 23:27:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:27:02 INFO - 'tsvgr_opacity', 23:27:02 INFO - 'tart', 23:27:02 INFO - 'tscrollx', 23:27:02 INFO - 'cart']}, 23:27:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:02 INFO - 'talos_options': ['--disable-e10s'], 23:27:02 INFO - 'tests': ['tp5o']}, 23:27:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:02 INFO - 'tests': ['tp5o']}, 23:27:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:02 INFO - 'talos_options': ['--disable-e10s', 23:27:02 INFO - '--xperf_path', 23:27:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:27:02 INFO - 'tests': ['tp5n']}, 23:27:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:02 INFO - 'talos_options': ['--xperf_path', 23:27:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:27:02 INFO - 'tests': ['tp5n']}}, 23:27:02 INFO - 'talos.zip': {'path': '', 23:27:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:27:02 INFO - Running post-action listener: _resource_record_post_action 23:27:02 INFO - [mozharness: 2016-10-20 06:27:02.582990Z] Finished populate-webroot step (success) 23:27:02 INFO - [mozharness: 2016-10-20 06:27:02.583080Z] Running create-virtualenv step. 23:27:02 INFO - Running pre-action listener: _resource_record_pre_action 23:27:02 INFO - Running main action method: create_virtualenv 23:27:02 INFO - Creating virtualenv /builds/slave/test/build/venv 23:27:02 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 23:27:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:27:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:27:02 INFO - Using real prefix '/usr' 23:27:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:27:03 INFO - Installing distribute.............................................................................................................................................................................................done. 23:27:05 INFO - Installing pip.................done. 23:27:05 INFO - Return code: 0 23:27:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:27:05 INFO - Reading from file tmpfile_stdout 23:27:05 INFO - Output received: 23:27:05 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) 23:27:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:27:05 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')]} 23:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:05 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')]} 23:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:05 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 0x7f3bae8a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a930>, '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 0x2a5b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5bcc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064', '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 23:27:05 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 23:27:05 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 23:27:05 INFO - Using env: {'DISPLAY': ':0', 23:27:05 INFO - 'HOME': '/home/cltbld', 23:27:05 INFO - 'LANG': 'en_US.UTF-8', 23:27:05 INFO - 'LANGUAGE': 'en_US:en', 23:27:05 INFO - 'LOGNAME': 'cltbld', 23:27:05 INFO - 'MAIL': '/var/mail/cltbld', 23:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:05 INFO - 'MOZ_NO_REMOTE': '1', 23:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:05 INFO - 'NO_EM_RESTART': '1', 23:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:05 INFO - 'PWD': '/builds/slave/test', 23:27:05 INFO - 'SHELL': '/bin/bash', 23:27:05 INFO - 'SHLVL': '1', 23:27:05 INFO - 'TERM': 'linux', 23:27:05 INFO - 'TMOUT': '86400', 23:27:05 INFO - 'USER': 'cltbld', 23:27:05 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064', 23:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:05 INFO - '_': '/tools/buildbot/bin/python'} 23:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:05 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 23:27:05 INFO - Cleaning up... 23:27:05 INFO - Return code: 0 23:27:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:27:05 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')]} 23:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:05 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')]} 23:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:05 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 0x7f3bae8a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a930>, '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 0x2a5b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5bcc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064', '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 23:27:05 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 23:27:05 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 23:27:05 INFO - Using env: {'DISPLAY': ':0', 23:27:05 INFO - 'HOME': '/home/cltbld', 23:27:05 INFO - 'LANG': 'en_US.UTF-8', 23:27:05 INFO - 'LANGUAGE': 'en_US:en', 23:27:05 INFO - 'LOGNAME': 'cltbld', 23:27:05 INFO - 'MAIL': '/var/mail/cltbld', 23:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:05 INFO - 'MOZ_NO_REMOTE': '1', 23:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:05 INFO - 'NO_EM_RESTART': '1', 23:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:05 INFO - 'PWD': '/builds/slave/test', 23:27:05 INFO - 'SHELL': '/bin/bash', 23:27:05 INFO - 'SHLVL': '1', 23:27:05 INFO - 'TERM': 'linux', 23:27:05 INFO - 'TMOUT': '86400', 23:27:05 INFO - 'USER': 'cltbld', 23:27:05 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064', 23:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:05 INFO - '_': '/tools/buildbot/bin/python'} 23:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:05 INFO - Downloading/unpacking psutil>=3.1.1 23:27:05 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 23:27:05 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 23:27:05 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 23:27:05 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 23:27:05 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 23:27:05 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 23:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:27:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:27:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:27:07 INFO - Installing collected packages: psutil 23:27:07 INFO - Running setup.py install for psutil 23:27:07 INFO - building 'psutil._psutil_linux' extension 23:27:07 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 23:27:08 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 23:27:08 INFO - building 'psutil._psutil_posix' extension 23:27:08 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 23:27:08 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 23:27:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:27:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:27:08 INFO - Successfully installed psutil 23:27:08 INFO - Cleaning up... 23:27:08 INFO - Return code: 0 23:27:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3bae8a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a930>, '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 0x2a5b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5bcc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064', '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 23:27:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:27:08 INFO - Using env: {'DISPLAY': ':0', 23:27:08 INFO - 'HOME': '/home/cltbld', 23:27:08 INFO - 'LANG': 'en_US.UTF-8', 23:27:08 INFO - 'LANGUAGE': 'en_US:en', 23:27:08 INFO - 'LOGNAME': 'cltbld', 23:27:08 INFO - 'MAIL': '/var/mail/cltbld', 23:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:08 INFO - 'MOZ_NO_REMOTE': '1', 23:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:08 INFO - 'NO_EM_RESTART': '1', 23:27:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:08 INFO - 'PWD': '/builds/slave/test', 23:27:08 INFO - 'SHELL': '/bin/bash', 23:27:08 INFO - 'SHLVL': '1', 23:27:08 INFO - 'TERM': 'linux', 23:27:08 INFO - 'TMOUT': '86400', 23:27:08 INFO - 'USER': 'cltbld', 23:27:08 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064', 23:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:08 INFO - '_': '/tools/buildbot/bin/python'} 23:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:27:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:27:10 INFO - Installing collected packages: mozsystemmonitor 23:27:10 INFO - Running setup.py install for mozsystemmonitor 23:27:10 INFO - Successfully installed mozsystemmonitor 23:27:10 INFO - Cleaning up... 23:27:10 INFO - Return code: 0 23:27:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:27:10 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')]} 23:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:10 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')]} 23:27:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:10 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 0x7f3bae8a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a930>, '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 0x2a5b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5bcc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064', '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 23:27:10 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 23:27:10 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 23:27:10 INFO - Using env: {'DISPLAY': ':0', 23:27:10 INFO - 'HOME': '/home/cltbld', 23:27:10 INFO - 'LANG': 'en_US.UTF-8', 23:27:10 INFO - 'LANGUAGE': 'en_US:en', 23:27:10 INFO - 'LOGNAME': 'cltbld', 23:27:10 INFO - 'MAIL': '/var/mail/cltbld', 23:27:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:10 INFO - 'MOZ_NO_REMOTE': '1', 23:27:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:10 INFO - 'NO_EM_RESTART': '1', 23:27:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:10 INFO - 'PWD': '/builds/slave/test', 23:27:10 INFO - 'SHELL': '/bin/bash', 23:27:10 INFO - 'SHLVL': '1', 23:27:10 INFO - 'TERM': 'linux', 23:27:10 INFO - 'TMOUT': '86400', 23:27:10 INFO - 'USER': 'cltbld', 23:27:10 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064', 23:27:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:10 INFO - '_': '/tools/buildbot/bin/python'} 23:27:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:10 INFO - Downloading/unpacking jsonschema==2.5.1 23:27:10 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 23:27:10 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 23:27:10 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 23:27:10 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 23:27:10 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 23:27:10 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 23:27:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:27:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:27:12 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 23:27:12 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 23:27:12 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 23:27:12 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 23:27:12 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 23:27:12 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 23:27:13 INFO - Downloading functools32-3.2.3-2.tar.gz 23:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:27:13 INFO - warning: no files found matching '*.txt' 23:27:13 INFO - no previously-included directories found matching 'build' 23:27:13 INFO - no previously-included directories found matching 'dist' 23:27:13 INFO - no previously-included directories found matching '.git*' 23:27:13 INFO - Installing collected packages: jsonschema, functools32 23:27:13 INFO - Running setup.py install for functools32 23:27:13 INFO - warning: no files found matching '*.txt' 23:27:13 INFO - no previously-included directories found matching 'build' 23:27:13 INFO - no previously-included directories found matching 'dist' 23:27:13 INFO - no previously-included directories found matching '.git*' 23:27:13 INFO - Successfully installed jsonschema functools32 23:27:13 INFO - Cleaning up... 23:27:13 INFO - Return code: 0 23:27:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:27:13 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')]} 23:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:13 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')]} 23:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:13 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 0x7f3bae8a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a930>, '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 0x2a5b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5bcc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064', '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 23:27:13 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 23:27:13 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 23:27:13 INFO - Using env: {'DISPLAY': ':0', 23:27:13 INFO - 'HOME': '/home/cltbld', 23:27:13 INFO - 'LANG': 'en_US.UTF-8', 23:27:13 INFO - 'LANGUAGE': 'en_US:en', 23:27:13 INFO - 'LOGNAME': 'cltbld', 23:27:13 INFO - 'MAIL': '/var/mail/cltbld', 23:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:13 INFO - 'MOZ_NO_REMOTE': '1', 23:27:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:13 INFO - 'NO_EM_RESTART': '1', 23:27:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:13 INFO - 'PWD': '/builds/slave/test', 23:27:13 INFO - 'SHELL': '/bin/bash', 23:27:13 INFO - 'SHLVL': '1', 23:27:13 INFO - 'TERM': 'linux', 23:27:13 INFO - 'TMOUT': '86400', 23:27:13 INFO - 'USER': 'cltbld', 23:27:13 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064', 23:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:13 INFO - '_': '/tools/buildbot/bin/python'} 23:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:27:13 INFO - Cleaning up... 23:27:13 INFO - Return code: 0 23:27:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:27:13 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')]} 23:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:13 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')]} 23:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:13 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 0x7f3bae8a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a930>, '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 0x2a5b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5bcc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064', '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 23:27:13 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 23:27:13 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 23:27:13 INFO - Using env: {'DISPLAY': ':0', 23:27:13 INFO - 'HOME': '/home/cltbld', 23:27:13 INFO - 'LANG': 'en_US.UTF-8', 23:27:13 INFO - 'LANGUAGE': 'en_US:en', 23:27:13 INFO - 'LOGNAME': 'cltbld', 23:27:13 INFO - 'MAIL': '/var/mail/cltbld', 23:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:13 INFO - 'MOZ_NO_REMOTE': '1', 23:27:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:13 INFO - 'NO_EM_RESTART': '1', 23:27:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:13 INFO - 'PWD': '/builds/slave/test', 23:27:13 INFO - 'SHELL': '/bin/bash', 23:27:13 INFO - 'SHLVL': '1', 23:27:13 INFO - 'TERM': 'linux', 23:27:13 INFO - 'TMOUT': '86400', 23:27:13 INFO - 'USER': 'cltbld', 23:27:13 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064', 23:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:13 INFO - '_': '/tools/buildbot/bin/python'} 23:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:13 INFO - Downloading/unpacking blobuploader==1.2.4 23:27:13 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 23:27:13 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 23:27:13 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 23:27:13 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 23:27:13 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 23:27:13 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 23:27:15 INFO - Downloading blobuploader-1.2.4.tar.gz 23:27:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:27:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:27:15 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 23:27:15 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 23:27:15 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 23:27:15 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 23:27:15 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 23:27:15 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 23:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:27:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:27:16 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 23:27:16 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 23:27:16 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 23:27:16 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 23:27:16 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 23:27:16 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 23:27:16 INFO - Downloading docopt-0.6.1.tar.gz 23:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:27:16 INFO - Installing collected packages: blobuploader, requests, docopt 23:27:16 INFO - Running setup.py install for blobuploader 23:27:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:27:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:27:16 INFO - Running setup.py install for requests 23:27:16 INFO - Running setup.py install for docopt 23:27:17 INFO - Successfully installed blobuploader requests docopt 23:27:17 INFO - Cleaning up... 23:27:17 INFO - Return code: 0 23:27:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:27: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')]} 23:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27: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')]} 23:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:17 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 0x7f3bae8a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a930>, '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 0x2a5b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5bcc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064', '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 23:27:17 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 23:27:17 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 23:27:17 INFO - Using env: {'DISPLAY': ':0', 23:27:17 INFO - 'HOME': '/home/cltbld', 23:27:17 INFO - 'LANG': 'en_US.UTF-8', 23:27:17 INFO - 'LANGUAGE': 'en_US:en', 23:27:17 INFO - 'LOGNAME': 'cltbld', 23:27:17 INFO - 'MAIL': '/var/mail/cltbld', 23:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:17 INFO - 'MOZ_NO_REMOTE': '1', 23:27:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:17 INFO - 'NO_EM_RESTART': '1', 23:27:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:17 INFO - 'PWD': '/builds/slave/test', 23:27:17 INFO - 'SHELL': '/bin/bash', 23:27:17 INFO - 'SHLVL': '1', 23:27:17 INFO - 'TERM': 'linux', 23:27:17 INFO - 'TMOUT': '86400', 23:27:17 INFO - 'USER': 'cltbld', 23:27:17 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064', 23:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:17 INFO - '_': '/tools/buildbot/bin/python'} 23:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:27:17 INFO - Running setup.py (path:/tmp/pip-4Q25Zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:27:17 INFO - Running setup.py (path:/tmp/pip-pOJ2wL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:27:17 INFO - Running setup.py (path:/tmp/pip-dX7WHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:27:17 INFO - Running setup.py (path:/tmp/pip-erPSDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:27:17 INFO - Running setup.py (path:/tmp/pip-xIhxw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:27:17 INFO - Running setup.py (path:/tmp/pip-_4TgUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:27:17 INFO - Running setup.py (path:/tmp/pip-fGPhS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:27:17 INFO - Running setup.py (path:/tmp/pip-w3Of3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:27:17 INFO - Running setup.py (path:/tmp/pip-mhZPAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:27:17 INFO - Running setup.py (path:/tmp/pip-VHvx1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:27:18 INFO - Running setup.py (path:/tmp/pip-q4XMq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:27:18 INFO - Running setup.py (path:/tmp/pip-lTGX69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:27:18 INFO - Running setup.py (path:/tmp/pip-B8d67L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:27:18 INFO - Running setup.py (path:/tmp/pip-fiV90Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:27:18 INFO - Running setup.py (path:/tmp/pip-lAVPw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:27:18 INFO - Running setup.py (path:/tmp/pip-Ha8MN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:27:18 INFO - Running setup.py (path:/tmp/pip-TV80Ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:27:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:27:18 INFO - Running setup.py install for manifestparser 23:27:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:27:18 INFO - Running setup.py install for mozcrash 23:27:18 INFO - Running setup.py install for mozdebug 23:27:18 INFO - Running setup.py install for mozdevice 23:27:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:27:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:27:18 INFO - Running setup.py install for mozfile 23:27:19 INFO - Running setup.py install for mozhttpd 23:27:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:27:19 INFO - Running setup.py install for mozinfo 23:27:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:27:19 INFO - Running setup.py install for mozInstall 23:27:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:27:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:27:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:27:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:27:19 INFO - Running setup.py install for mozleak 23:27:19 INFO - Running setup.py install for mozlog 23:27:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:27:19 INFO - Running setup.py install for moznetwork 23:27:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:27:19 INFO - Running setup.py install for mozprocess 23:27:19 INFO - Running setup.py install for mozprofile 23:27:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:27:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:27:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:27:19 INFO - Running setup.py install for mozrunner 23:27:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:27:20 INFO - Running setup.py install for mozscreenshot 23:27:20 INFO - Running setup.py install for moztest 23:27:20 INFO - Running setup.py install for mozversion 23:27:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:27:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:27:20 INFO - Cleaning up... 23:27:20 INFO - Return code: 0 23:27:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:27: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')]} 23:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27: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')]} 23:27:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:20 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 0x7f3bae8a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a930>, '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 0x2a5b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5bcc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064', '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 23:27:20 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 23:27:20 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 23:27:20 INFO - Using env: {'DISPLAY': ':0', 23:27:20 INFO - 'HOME': '/home/cltbld', 23:27:20 INFO - 'LANG': 'en_US.UTF-8', 23:27:20 INFO - 'LANGUAGE': 'en_US:en', 23:27:20 INFO - 'LOGNAME': 'cltbld', 23:27:20 INFO - 'MAIL': '/var/mail/cltbld', 23:27:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:20 INFO - 'MOZ_NO_REMOTE': '1', 23:27:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:20 INFO - 'NO_EM_RESTART': '1', 23:27:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:20 INFO - 'PWD': '/builds/slave/test', 23:27:20 INFO - 'SHELL': '/bin/bash', 23:27:20 INFO - 'SHLVL': '1', 23:27:20 INFO - 'TERM': 'linux', 23:27:20 INFO - 'TMOUT': '86400', 23:27:20 INFO - 'USER': 'cltbld', 23:27:20 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064', 23:27:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:20 INFO - '_': '/tools/buildbot/bin/python'} 23:27:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:27:20 INFO - Running setup.py (path:/tmp/pip-rrD1LA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:27:20 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)) 23:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:27:20 INFO - Running setup.py (path:/tmp/pip-MvT51i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:27:20 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)) 23:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:27:20 INFO - Running setup.py (path:/tmp/pip-LQQsBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:27:20 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)) 23:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:27:20 INFO - Running setup.py (path:/tmp/pip-BlBEOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:27:20 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)) 23:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:27:20 INFO - Running setup.py (path:/tmp/pip-gx5msc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:27:20 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)) 23:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:27:20 INFO - Running setup.py (path:/tmp/pip-6U7JmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:27:21 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)) 23:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:27:21 INFO - Running setup.py (path:/tmp/pip-v0ixxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:27:21 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)) 23:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:27:21 INFO - Running setup.py (path:/tmp/pip-_2HiTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:27:21 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)) 23:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:27:21 INFO - Running setup.py (path:/tmp/pip-IUQuCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:27:21 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)) 23:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:27:21 INFO - Running setup.py (path:/tmp/pip-7ruQ_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:27:21 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)) 23:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:27:21 INFO - Running setup.py (path:/tmp/pip-Wf800O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:27:21 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)) 23:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:27:21 INFO - Running setup.py (path:/tmp/pip-qD2AFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:27:21 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)) 23:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:27:21 INFO - Running setup.py (path:/tmp/pip-tW0n5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:27:21 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)) 23:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:27:21 INFO - Running setup.py (path:/tmp/pip-I7epXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:27:21 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)) 23:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:27:21 INFO - Running setup.py (path:/tmp/pip-sOjSId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:27:21 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)) 23:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:27:21 INFO - Running setup.py (path:/tmp/pip-NiFzmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:27:21 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)) 23:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:27:21 INFO - Running setup.py (path:/tmp/pip-I0CmNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:27:21 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)) 23:27:21 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)) 23:27:21 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)) 23:27:21 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)) 23:27:21 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)) 23:27:21 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)) 23:27:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:23 INFO - Downloading blessings-1.6.tar.gz 23:27:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:27:24 INFO - Installing collected packages: blessings 23:27:24 INFO - Running setup.py install for blessings 23:27:24 INFO - Successfully installed blessings 23:27:24 INFO - Cleaning up... 23:27:24 INFO - Return code: 0 23:27:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:27:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:27:24 INFO - Reading from file tmpfile_stdout 23:27:24 INFO - Current package versions: 23:27:24 INFO - argparse == 1.2.1 23:27:24 INFO - blessings == 1.6 23:27:24 INFO - blobuploader == 1.2.4 23:27:24 INFO - docopt == 0.6.1 23:27:24 INFO - functools32 == 3.2.3-2 23:27:24 INFO - jsonschema == 2.5.1 23:27:24 INFO - manifestparser == 1.1 23:27:24 INFO - mozInstall == 1.12 23:27:24 INFO - mozcrash == 0.17 23:27:24 INFO - mozdebug == 0.1 23:27:24 INFO - mozdevice == 0.48 23:27:24 INFO - mozfile == 1.2 23:27:24 INFO - mozhttpd == 0.7 23:27:24 INFO - mozinfo == 0.9 23:27:24 INFO - mozleak == 0.1 23:27:24 INFO - mozlog == 3.4 23:27:24 INFO - moznetwork == 0.27 23:27:24 INFO - mozprocess == 0.23 23:27:24 INFO - mozprofile == 0.28 23:27:24 INFO - mozrunner == 6.12 23:27:24 INFO - mozscreenshot == 0.1 23:27:24 INFO - mozsystemmonitor == 0.3 23:27:24 INFO - moztest == 0.7 23:27:24 INFO - mozversion == 1.4 23:27:24 INFO - psutil == 3.1.1 23:27:24 INFO - requests == 1.2.3 23:27:24 INFO - wsgiref == 0.1.2 23:27:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:27:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:24 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 0x7f3bae8a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a930>, '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 0x2a5b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5bcc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064', '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 23:27:24 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 23:27:24 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 23:27:24 INFO - Using env: {'DISPLAY': ':0', 23:27:24 INFO - 'HOME': '/home/cltbld', 23:27:24 INFO - 'LANG': 'en_US.UTF-8', 23:27:24 INFO - 'LANGUAGE': 'en_US:en', 23:27:24 INFO - 'LOGNAME': 'cltbld', 23:27:24 INFO - 'MAIL': '/var/mail/cltbld', 23:27:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:24 INFO - 'MOZ_NO_REMOTE': '1', 23:27:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:24 INFO - 'NO_EM_RESTART': '1', 23:27:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:24 INFO - 'PWD': '/builds/slave/test', 23:27:24 INFO - 'SHELL': '/bin/bash', 23:27:24 INFO - 'SHLVL': '1', 23:27:24 INFO - 'TERM': 'linux', 23:27:24 INFO - 'TMOUT': '86400', 23:27:24 INFO - 'USER': 'cltbld', 23:27:24 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064', 23:27:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:24 INFO - '_': '/tools/buildbot/bin/python'} 23:27:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:24 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)) 23:27:24 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)) 23:27:24 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)) 23:27:24 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)) 23:27:24 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)) 23:27:24 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)) 23:27:24 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)) 23:27:24 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)) 23:27:24 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)) 23:27:24 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)) 23:27:24 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)) 23:27:24 INFO - Cleaning up... 23:27:24 INFO - Return code: 0 23:27:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:27:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3bae8a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a930>, '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 0x2a5b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5bcc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064', '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 23:27:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:27:24 INFO - Using env: {'DISPLAY': ':0', 23:27:24 INFO - 'HOME': '/home/cltbld', 23:27:24 INFO - 'LANG': 'en_US.UTF-8', 23:27:24 INFO - 'LANGUAGE': 'en_US:en', 23:27:24 INFO - 'LOGNAME': 'cltbld', 23:27:24 INFO - 'MAIL': '/var/mail/cltbld', 23:27:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:24 INFO - 'MOZ_NO_REMOTE': '1', 23:27:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:24 INFO - 'NO_EM_RESTART': '1', 23:27:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:24 INFO - 'PWD': '/builds/slave/test', 23:27:24 INFO - 'SHELL': '/bin/bash', 23:27:24 INFO - 'SHLVL': '1', 23:27:24 INFO - 'TERM': 'linux', 23:27:24 INFO - 'TMOUT': '86400', 23:27:24 INFO - 'USER': 'cltbld', 23:27:24 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064', 23:27:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:24 INFO - '_': '/tools/buildbot/bin/python'} 23:27:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:27:24 INFO - Cleaning up... 23:27:24 INFO - Return code: 0 23:27:24 INFO - Running post-action listener: _resource_record_post_action 23:27:24 INFO - Running post-action listener: _start_resource_monitoring 23:27:24 INFO - Starting resource monitoring. 23:27:24 INFO - [mozharness: 2016-10-20 06:27:24.955186Z] Finished create-virtualenv step (success) 23:27:24 INFO - [mozharness: 2016-10-20 06:27:24.955652Z] Running install step. 23:27:24 INFO - Running pre-action listener: _resource_record_pre_action 23:27:24 INFO - Running main action method: install 23:27:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:27:25 INFO - Reading from file tmpfile_stdout 23:27:25 INFO - Detecting whether we're running mozinstall >=1.0... 23:27:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:27:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:27:25 INFO - Reading from file tmpfile_stdout 23:27:25 INFO - Output received: 23:27:25 INFO - Usage: mozinstall [options] installer 23:27:25 INFO - Options: 23:27:25 INFO - -h, --help show this help message and exit 23:27:25 INFO - -d DEST, --destination=DEST 23:27:25 INFO - Directory to install application into. [default: 23:27:25 INFO - "/builds/slave/test"] 23:27:25 INFO - --app=APP Application being installed. [default: firefox] 23:27:25 INFO - mkdir: /builds/slave/test/build/application 23:27:25 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'] 23:27:25 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 23:27:42 INFO - Reading from file tmpfile_stdout 23:27:42 INFO - Output received: 23:27:42 INFO - /builds/slave/test/build/application/firefox/firefox 23:27:42 INFO - Running post-action listener: _resource_record_post_action 23:27:42 INFO - [mozharness: 2016-10-20 06:27:42.195461Z] Finished install step (success) 23:27:42 INFO - [mozharness: 2016-10-20 06:27:42.195707Z] Running run-tests step. 23:27:42 INFO - Running pre-action listener: _resource_record_pre_action 23:27:42 INFO - Running main action method: run_tests 23:27:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:27:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:27:42 INFO - Python 2.7.3 23:27:42 INFO - Return code: 0 23:27:42 INFO - grabbing minidump binary from tooltool 23:27:42 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')]} 23:27:42 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 0x2a5a930>, '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 0x2a5b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5bcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:27:42 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 23:27:42 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 23:27:42 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 23:27:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:27:42 INFO - Return code: 0 23:27:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:27:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:27:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:27:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:27:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:27:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:27:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:27:42 INFO - Using env: {'DISPLAY': ':0', 23:27:42 INFO - 'HOME': '/home/cltbld', 23:27:42 INFO - 'LANG': 'en_US.UTF-8', 23:27:42 INFO - 'LANGUAGE': 'en_US:en', 23:27:42 INFO - 'LOGNAME': 'cltbld', 23:27:42 INFO - 'MAIL': '/var/mail/cltbld', 23:27:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:27:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:42 INFO - 'MOZ_NO_REMOTE': '1', 23:27:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:27:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:42 INFO - 'NO_EM_RESTART': '1', 23:27:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:42 INFO - 'PWD': '/builds/slave/test', 23:27:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:27:42 INFO - 'SHELL': '/bin/bash', 23:27:42 INFO - 'SHLVL': '1', 23:27:42 INFO - 'TERM': 'linux', 23:27:42 INFO - 'TMOUT': '86400', 23:27:42 INFO - 'USER': 'cltbld', 23:27:42 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064', 23:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:42 INFO - '_': '/tools/buildbot/bin/python'} 23:27:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:27:42 INFO - mozversion application_buildid: 20161019204247 23:27:42 INFO - mozversion application_changeset: cc5d68a2fcf8f2344f5f46595d8f1194c286a9c7 23:27:42 INFO - mozversion application_display_name: Nightly 23:27:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:27:42 INFO - mozversion application_name: Firefox 23:27:42 INFO - mozversion application_remotingname: firefox 23:27:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 23:27:42 INFO - mozversion application_vendor: Mozilla 23:27:42 INFO - mozversion application_version: 52.0a1 23:27:42 INFO - mozversion platform_buildid: 20161019204247 23:27:42 INFO - mozversion platform_changeset: cc5d68a2fcf8f2344f5f46595d8f1194c286a9c7 23:27:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 23:27:42 INFO - mozversion platform_version: 52.0a1 23:27:42 INFO - using testdate: 1476944862 23:27:42 INFO - actual date: 1476944862 23:27:42 INFO - starting webserver on 'localhost:36382' 23:27:42 INFO - SUITE-START | Running 2 tests 23:27:42 INFO - TEST-START | dromaeo_css 23:27:42 INFO - operating with platform_type : linux_ 23:27:42 INFO - Initialising browser for dromaeo_css test... 23:27:42 INFO - TEST-INFO | started process 2190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPVPURc/profile http://localhost:36382/getInfo.html) 23:27:47 INFO - PROCESS | 2190 | __metrics Screen width/height:1600/1200 23:27:47 INFO - PROCESS | 2190 | colorDepth:24 23:27:47 INFO - PROCESS | 2190 | Browser inner width/height: 1024/697 23:27:47 INFO - PROCESS | 2190 | __metrics 23:27:47 ERROR - PROCESS | 2190 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 23:27:48 INFO - TEST-INFO | 2190: exit 0 23:27:48 INFO - Browser initialized. 23:27:48 INFO - Running cycle 1/1 for dromaeo_css test... 23:27:48 INFO - TEST-INFO | started process 2313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPVPURc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:28:00 INFO - PROCESS | 2313 | RSS: Main: 182435840 23:28:00 INFO - PROCESS | 2313 | 23:28:50 INFO - PROCESS | 2313 | 1476944930429 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] 23:31:01 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:36382/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36382/tests/dromaeo/cssquery-ext.html) 23:31:03 INFO - PROCESS | 2313 | RSS: Main: 196345856 23:31:03 INFO - PROCESS | 2313 | 23:34:05 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:36382/tests/dromaeo/cssquery-ext.html (next: http://localhost:36382/tests/dromaeo/cssquery-jquery.html) 23:34:06 INFO - PROCESS | 2313 | RSS: Main: 194031616 23:34:06 INFO - PROCESS | 2313 | 23:37:08 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:36382/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36382/tests/dromaeo/cssquery-mootools.html) 23:37:08 INFO - PROCESS | 2313 | RSS: Main: 196239360 23:37:08 INFO - PROCESS | 2313 | 23:40:10 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:36382/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36382/tests/dromaeo/cssquery-prototype.html) 23:40:11 INFO - PROCESS | 2313 | RSS: Main: 192716800 23:40:11 INFO - PROCESS | 2313 | 23:43:13 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:36382/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36382/tests/dromaeo/cssquery-yui.html) 23:43:14 INFO - PROCESS | 2313 | RSS: Main: 196153344 23:43:14 INFO - PROCESS | 2313 | 23:46:17 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:36382/tests/dromaeo/cssquery-yui.html (next: http://localhost:36382/tests/dromaeo/cssquery-dojo.html) 23:46:17 INFO - PROCESS | 2313 | RSS: Main: 195686400 23:46:17 INFO - PROCESS | 2313 | 23:46:17 INFO - PROCESS | 2313 | __start_tp_report 23:46:17 INFO - PROCESS | 2313 | _x_x_mozilla_page_load 23:46:17 INFO - PROCESS | 2313 | _x_x_mozilla_page_load_details 23:46:17 INFO - PROCESS | 2313 | |i|pagename|runs| 23:46:17 INFO - PROCESS | 2313 | |0;dojo.html;3071.447139514888;3077.5383692446135;3079.9846000769994;3080.199148221463;3092.180572148381;5332.306800115989;5399.163129714891;5403.2165336026255;5410.05324068288;5553.944460555394;5330.333708286465;5422.267993820833;5496.917546236809;5505.559555235582;5552.583556233279;4888.706677599338;4960.578350840165;4962.751862406865;4986.248775320398;5054.368203974504;4928.728919909404;4993.350864387643;5017.573506251954;5044.369453818273;5077.41609714882;4768.809247630125;4939.580135688435;4982.103221420143;5013.724245166514;5018.949810501903;4848.248521479177;4880.585150262232;4907.828226012072;4922.975385123087;4994.525520075587;4854.902901941941;4857.344258525124;4876.390451193601;4880.951190488121;4933.309336692866;5352.785888564492;5380.488853558905;5387.81142660005;5407.297051383334;5436.320459942507;5663.801766938179;5704.201411802351;5780.306363236438;5809.302883653946;5811.215485909391;5875.324337701177;5876;5891.440313170242;5895;5948.7620495180145;5435.103207970719;5456.536194423518;5458.399576046631;5460.426655201187;5470.56235501159;5765.625234359753;5865.35481097079;5904.380040095814;5918.112283157475;5934.525237980951;5741.569382296261;5749.913751293734;5750.539956803445;5776.797812076641;5808.796692115756;5780.1907732917425;5789.131630255495;5835.94164058354;5847.06446968483;5855.4730074292665;5596.804111856066;5668.716564171775;5736.971315143398;5739.253896993364;5754.913676294859;5751.683657398883;5770.971145144247;5772.942270577324;5782.392848750905;5833.358330583633;4364.367166760802;4365.738055716667;4369.584889435499;4376.277914144131;4417.646588272931;3841.9039524012123;3873.7288389813007;3885.592012838668;3907.277153726513;3938.3895496198134;5582.7766889323975;5588.469095435927;5589.329280486287;5604.439556044363;5615.354234263112;5855.2973643163095;5855.443732845458;5873.706314684248;5887.087501437284;5890.49930755882;5405.189221616789;5426.701531415731;5512.173174023848;5568.303962004749;5589.496945274945;4856.562909338177;4901.779419926112;4940.333055037524;4945.876353091202;4987.451380348159;6001.669908155093;6032.54755893301;6074.453299203093;6084.847878802977;6098.054801505774;5658.462446067617;5709.22925405065;5854.4730974212525;5869.765209391577;5890.970545147246;5949.583529152917;5987.2815262168815;6001.339852616122;6033.909491357721;6086.3305036446845;5696.316442026983;5710.172025056427;5728.083506638918;5745.166950792195;5749.396313387034;5647.6893770843;5836.124581312667;5838.970805145947;5847.26909136358;5851.64890106595;5567.944320556742;5585.916211256916;5663.5469162467725;5666.263385759989;5756.71216439168;5661.745221464962;5663.5469162467725;5663.57523185771;5676.375598684224;5678.432156784289;5472.781088756406;5622.522085622768;5625.381208067028;5659.094544872801;5662.867426514796;5736.627119237236;5765.077587586134;5765.596408251382;5810.070388737781;5863.618864773776;5627.437256274504;5663.263775709296;5669.34802497718;5677.659340439587;5684.289463817023 23:46:17 INFO - PROCESS | 2313 | |1;ext.html;557.292238856652;575.2550447170913;582.839719077254;584.3513699793232;595.7021489255371;40596.391054134176;41004;42265.15469690608;45843;46104.308435373496;43400.34899476502;43555.12889742203;43884.341734873924;43891.34162987558;43892.78053609728;8706.347023973196;8865.290776737878;8868.334874884376;8869.157430044135;8878.778030549223;8727.301815854747;8815.559222038904;8830.911690883106;8832.072632373605;8839.60221790021;8846.778830529256;8899.599518021672;8905.198532132139;8907.68823091192;8928.508932008737;8781.473111613324;8786.638071098925;8789.95605021974;8834.425762325429;8846.5576721164;8638.265747411477;8700.869486957701;8786.209241168326;8787.516686582236;8808.471491710454;39753;40249.798751006354;40260.59739402627;40283;40472;3478.3912815257227;3487.511748355232;3555.6622120898473;3569.803660798655;3600.7757362496877;30971.69028309733;31390.215244618837;31447.213819654462;31478.37043259122;31490.212744681565;4155.729877557949;4294.098239369736;4328.956710432918;4366.628836548865;4382.123575284956;330816;330996;332760;332895.3355233233;333195;54159.729201353744;54204.45795542073;54289.72855135699;54618.726906366006;54667.45332546624;56058;56573.7171314149;56611.15083273754;56691.71654141703;57026.714866426235;15684.921575392278;16035.037897726173;16087.115208663401;16092.919535402249;16093.678126437406;12296.815547766791;12417.503299868085;12527.248365098123;12539.686507837378;12540.937295313464;14625.561233163022;15172.620684482976;15298.847011529964;15314.387424502895;15462.304196311194;5991.5206783457215;6079.148919151322;6316.684165791784;6356.809295721136;6454;924.2605915267759;1005.1556692378291;1006.2050979726081;1101.3061771084165;1110.7278716714295;31618.841905790785;31697.52453713196;31755;31847.840760796047;31923.669680843086;987.5852142100335;1036.7149034015706;1076.6447072466224;1152.5850693750244;1157.7279339355246;15928.76106858398;16487.422940197277;16559.25483353252;16647.250873710713;16828.24272907722;500471;503908.92182156886;504514;505590;507232;57260.42739572634;57572.424275756704;57603.99999999916;57708.422915771145;57779.422205778246;1265.8417697787777;1288.2656885575132;1323.67569945364;1328.6279841644355;1331.1281110872587;28736.568951465328;30145.24636884008;30888.38223235478;30972.380552388375;31124.53313200349;48642.75678621584;48857.267140992204;48889.266661000824;48988;49001.93464209133;432504;434336;435015;437658;438644;38282;38717;39259;39635.60364396434;39770;45953;46483.767581161876;46643.533564665275;47371;47944;38843.02872999192;40053.1989360217;40324.19351612893;41581.37627935644;42005.78997104995;40016;40407.1918561633;41298.79350603228;41441;42161.156776864904;39680.83351248193;39857;39941.2011759769;40001.399978999754;40118.39822402608;34107.31785364328;36667.81666091653;36969.26061478702;37045.44431833579;37188.39681222288;27838;28046.57930131009;28164.85917570399;28225.43549129047;28333 23:46:17 INFO - PROCESS | 2313 | |2;jquery.html;374.3561074951083;387.33765261403;389.29731834039546;393.1037235103964;399.73217943977534;18393.264269429223;20181.29365472209;20339.796602033974;20352.389428317154;20380;18827.05864706766;19000.04999750014;19222.903885480588;19241.518962025923;19319.420417387464;4965.801367945278;5589.217509548656;5847.327557330897;5847.766089356421;6376.139221205148;6503.544751867371;6558.836029099263;6562.540622156451;6570.93429065708;6578.80263592093;6159.568830181889;6462.870742585145;6473.44975677068;6530.869382612344;6577.539572229945;5940.435658612425;6137.110119032715;6516.543841931067;6555.410013098844;6576.80269591913;5767.711614419304;5768.97115514424;5780.942190578083;5785.681787501686;5787.160861675034;13546.390412431365;14002.789958150635;14009.439622415091;14015.719685606231;14016.299185040809;2223.3663405929397;2231.3306008197474;2231.364061242538;2272.2388000020014;3033.8179709217516;15142.242887855673;15215.695686086216;15307;16090.5977350566;16844.32622695103;1999.1403696410537;2001.0995052226556;2029.401326608654;2068.4621998280404;2116.608427440913;93799.23950592779;94135.52932235294;95377.52311238469;98132;101994;17080.743788843178;17778.822211777977;17790.822091779177;17991.851426000398;18055.458336249932;31540.684593154234;31594.368112637618;31640.208994775316;31649.84175079156;31950.680493195236;9604.327697061139;9654.22766178704;9675.90324096764;9824.164945979672;9970.45162516054;7931.603419829101;8039.196080391914;8142.806454675847;8384.664613415394;8389.74153876911;8524.717983576367;8608.225259726654;8723.476591404537;8846.690365837165;9070.825211176167;3236.449803533405;3311.850966706504;3339.215284408162;3391.559097317333;3402.557667503209;891.3715830339595;974.8878878928872;986.2800155886243;1016.9491525423699;1017.7048655889857;18697.626047478974;19433.611327773364;19717.60564788725;19782.802171978095;20037.49906252326;894.4677916639589;958.2184897362251;965.4255717847869;968.2350942755286;1023.9129673977795;10952.56189752401;11069.446527673585;11115.166362522843;11248.493817778219;11279.830802537968;424975;428641;447645;447729;449402;90169.54915225513;91621.54189229012;91892;91938;92622;932.4032619123766;947.5877993072897;967.7048500207363;974.1670871404989;976.8095221431895;16863.325466981183;17269.827301727324;17710.90059239602;17747.46757597274;17784.79790452546;41535.58464415317;42514.57485425106;42684;42866.5713342875;42928.57071429246;54664.18003730027;55897;56419.43580564142;56718.14922776244;57184.71407642935;7991.440599158003;8276.793080173044;8416.242538171595;8802.823943521222;8809.075047120217;12282.87717122853;13132.277724725232;13520.594382168158;13585.932070339584;13779.035467517579;10487.580496780043;10912;10961.671149865517;11352.94323528377;11586.71033224176;11597.594084207012;11905.761884762083;11978.46096925658;12000.939995300318;12347.876521234673;11867.525298987945;11940;11948.880511194777;12057.457414416196;12557.372131393577;8137.593120344078;8169.673213071411;8282.668693252443;8335.624896879775;8381.16188381157;8497.957510212409;11000.944995274973;11208.71978200519;11557.364344961108;11838.230515016496 23:46:17 INFO - PROCESS | 2313 | |3;mootools.html;1454.403694485261;1476.4094362255096;1621.5135459362195;1725.6031112844037;1757.3322137587722;8037.397195210368;8306.958465207674;8379.832403351944;8928.464292142467;8961.955190224056;8508.74473765788;8832.425892316995;8846.071162527938;9018;9058.90941090589;2292.977070229297;2318.1307009871216;2330.3475026992382;2330.88345582721;2333.731620863597;2259.0963614554144;2273.693051438051;2330.3125577954543;2364.7871691547757;2374.192774456693;2304.76952304769;2310.7111611048617;2327;2337.6960995070617;2359.304005318427;2252.7409347925036;2259.6497542880797;2265.478939843837;2270.9318720438414;2274.0556823915563;2209.1163534586294;2220.9666854997026;2228.5320082782637;2228.765979572154;2231.252530402301;8963.10368963105;8998.505082220476;9014.36899417041;9016.909830901672;9053.230475409599;5217.42608313089;5371.75827087782;5375.838724838261;5390.568754499631;5399.595030372738;3326.7837590556537;3362.680545348188;3518.4194607889667;3536.45184996326;3548.5919119301093;1073.7047311989188;1095.4686976816238;1107.1032463704344;1109.938953357565;1138.1805100327751;12239.388030598524;12243;12288.631341059692;12337.383130843511;12339.444724987397;4410.206162890647;4533.637309015271;4639.48965613789;4667.766611669403;4745.549172828576;10299.12457441111;10374.118199953089;10375.118114960313;10389.324693894872;10439.129239459058;5408.378036525771;5410.59420543453;5435.836924892181;5446.1558458439;5449.836504904859;4244.129953359554;4375.146846364928;4688.109259240733;4781.497942716034;5011.09800235961;3873.5932727063814;3900.7659540427667;3960.1089754805516;3997.300472417315;4008.158286759755;1249.1568191470903;1249.5564074753513;1253.993730031344;1271.0467149637773;1272.465564462928;766.9079710434784;939.7133874168308;940.2431043010442;955.5556666150135;962.8157366439319;5735.738137609719;5769.624974376652;5918.911216331759;5946.345901950782;6441.677916104176;904.674317245791;927.3369540778376;951.9095685909828;955.603424578792;976.72651657536;3791.374423220193;4091.529474110456;4171.1032128092;4182.665386769051;4277.486701595828;10571.894281057244;10752.354858708502;10866.07638350749;10956.506957186946;11128.944355278172;11049.668509944715;11102.555897764161;11111.444427778579;11113.166512511594;11124.777504450027;7856.450048496665;8245.628946697412;8293.33653307734;8320.750377488806;8333.208345207195;5972.343042265435;5993.190919226023;6017.458428741435;6027.668478233739;6167.475764559883;9872.40765554069;9888.406695598287;10011.949940250252;10046.196304295785;10063.194944404577;9732.41605503672;10032.799344012932;10033.548490317808;10248.128909042814;10356.689299320731;7128.643567821692;7381.704731810667;7569.394448444222;7832.412569057457;8025.2777250047775;8356.415050946618;8808.427452215585;8821;8825.117488251124;8834.160754728291;7704.422168337509;7721.227877212234;7729.4202934779;7858.803529911569;7990.84018319642;7466.552006879605;7523.285287897641;7691.077070751546;7726.729564465217;7779.533228006338;6710.328967103251;6820.556663817035;6839.93160068393;6844.828879278058;6849.383555480031;4811.302361157543;4845.103655823684;4927.457979622167;5017.698938063728;5115.130427827204;5106.974465127651;5117.8720531987;5122;5171.767270472763;5171.844844654666 23:46:17 INFO - PROCESS | 2313 | |4;prototype.html;321.3284235946871;326.2219606239119;330.3646947609333;335.7347695320696;341.375283231686;5431.945680543194;5601.775928962837;5621.662700237988;5628.127640215763;5644.463775941284;5459.372172200198;5541.833744987657;5565.471280228382;5568.303962004749;5597.8600534986645;4306.698531102824;4349.826006959718;4354.8911277218;4366.956330436703;4372.83544645401;4191.55988621195;4268.850590229343;4293.270144075499;4312.353147027955;4328.826846926119;4271.9359209611885;4273.401723758676;4279.2083464559;4286.785660716967;4290.940348632658;4213.188329018521;4274.465691788527;4279.144171165779;4284.700070995047;4289.270823959934;3690.464882592009;3760.8871733848027;3768.5854555998817;3777.471154038437;3788.753731007503;5325.920111198335;5327.946720532823;5336;5357.866053348658;5413.430105269506;4904.926426103576;4906.460289368167;4916.303875163063;4920.926186107211;4926.45808961014;5666.801661941812;5772;5780.537556995472;5851.268591426072;5860.443257890493;4108.993296642342;4109.938350924738;4113.382992551141;4115.8971025724295;4134.255833949888;5981.312149102865;6030.185924900126;6126.632402055891;6129.601575897553;6136.072913335469;4065.6137666921595;4222.619964203236;4232.470941132358;4233.7883105844585;4243.8090285937205;4248.8300467980935;4269.957300427018;4273.807678654468;4279.358096285582;4283.800535849967;4879.194932836113;4936.308916751657;4953.25701144824;4968.453470118284;4990.800367985313;5648.774049038075;5832.825015249549;5895.675737834375;5905.586608937419;5930.644161350333;1419.7302512522588;1452.782082687584;1461.1379286221181;1467.8238611366705;1475.8450362711976;902.4675441489421;921.1847514949318;936.166811537732;944.6032666280179;945.4988855906244;4934.631376939089;4949.430815456269;4952.752362381939;4972.950270497248;4976.884823949807;5199.11615025439;5227.294315267391;5236.92144617831;5263.26314315996;5271.973640131775;4780.808767649255;4838.879028024327;4925.975370123198;4930.334404855299;4950.985048065138;2737.7262273772462;2760.8619569021466;2794.351332713709;2805.5791631255474;2821.463921854841;5347.919781203285;5351.81268655603;5353.170258609922;5379.67721936685;5394.595405344537;4921.753912304371;5193.844184674465;5207.973960130175;5214.3053507610175;5280.788768449219;5271.7578689106695;5288.65623734456;5303.7348132593215;5338.706371149547;5370.812021579148;5225.216217567396;5230.529252367305;5256.868578285574;5262.289590905179;5269.631125821309;5190.455002224712;5490.121580547093;5866.882662346644;5900.1149827526215;5906.911396329145;6149.754009839557;6191.690415479298;6200.968995154995;6270.529710271657;6273.435390814849;4033.677305815469;4225.556316586837;4230.725002874803;4276.5082015568605;4291.291936830513;5819.272590926134;5925.970370148121;5938.406159384027;5951.732172052181;5987.461128498456;5763.423657634203;5773.826785196451;5825.242718446744;5827.912581311199;5856.648601083949;5755.424457554379;5766.308043034863;5767.163761254678;5770.451807078321;5778.711064446845;5680.744366503434;5737.655740655574;5779.988502012047;5813.418658134153;5842.737076831468;5820.388859169726;5824.825255242349;5834.38738932406;5860.941390586039;5862.882742345215;5608.4111168326735;5669.858253543694;5705.686187259741;5732.656040637575;5738.942610573841 23:46:17 INFO - PROCESS | 2313 | |5;yui.html;740.4964624055642;788.2747871957802;788.3732432715993;820.1839170025826;864.7189663359405;15534.533963981085;16495.092769897652;16552.75170872438;16596.087215203173;16642.25109870056;13973.161610303363;14054.789178162337;14062;14094.647633809134;14183.432662693505;769.7613739740684;790.5928446849877;813.780279324582;814.4624547798454;821.1337039423406;807.112176605732;811.995940020299;814.1085511365046;814.2630919018297;814.5479259011246;841.6380956188837;847.326375531454;847.4915050969431;849.8512760266929;850.4259624753298;836.0469065265602;842.5492361586553;843.7763992541982;845.1632883445407;845.5222799118478;613.5980932489226;613.6011592464889;614.7940439952577;615.1818081951039;616.7594638091148;13858.16850988944;13865.722685546334;13898.51355202563;13902.58292251224;13930.791038134435;14151.29243537819;14153.575392738234;14177.78733319001;14406.495772648012;14613.830893528493;12081.818772718416;12195;12255.93872030643;12399.62801115959;12580.056495762854;3579.391503444395;3604.6755791978585;3658.707303415747;3687.322268367913;3707.3326801175776;84329;84706.15293847045;84745.57627211887;85389;88675.55662221648;10825.945870270756;11022.559097636005;11048.226624136234;11249;11356.148288878367;20400.387988360373;20646;20815.583688326147;20816.47958801012;20897.268595599082;8257.710980115668;8291.170882911661;8302.418830681914;8440.451370660887;8525.232729054414;4577.473590537064;4608.078384323148;4621.2837010263465;4665.323528088408;4685.672002959828;3488.808115553669;3544.6455354464347;3582.2119133790525;3607;3608.585012723518;628.0704557255287;636.7516668499289;639.2488825629866;643.9034144878212;655.9311272316338;575.1709563587831;629.087822657149;650.1807722269974;664.5049438168595;675.6621689155422;8899.955500222457;9268.512511699551;9317.534123293808;9594.904050959542;9984.650537231162;581.7294957844623;601.0623427453187;686.4234043403565;687.7249100359896;777.4363586399814;4404.405405270311;4573.47405048417;4621.445426548836;4659.138059459011;4808.35087263222;64546.35453645497;65993.34006659967;66310.66844665745;74612;110421.44789276003;86396.56801715952;89638.55180724054;90015.54992224996;91310.54344728366;92887.53556232176;53154.7342263294;55000;71439.64280178565;81601.18398816054;84799.57600211959;8747.737567872973;8859.955700221457;8871.467711937305;9168.129027742354;9200.907990920274;48303;48493.75753121212;48676.75661621811;49619.75190124026;49939.75030124826;66844.33155668381;73967.26032739604;74346.62826685832;74651;80245.5987720081;11660.650180494598;11764.70588235301;11890.762184756084;12161.635150945485;12253.571125010581;13073.280969546386;13141.277229752073;13201.60395188146;13263.602091937257;13817.378217980015;11892.881071189177;12412.379381031093;12500.187487813264;12710.745785084431;13450.12574182675;12078.698032549257;12155.635330940086;12481.313527755698;12498.687532811753;12731;11015.559377624806;11211.271267367594;11505.42472876336;11632.767344653228;11886.524539018343;10350.430726310125;10375;10389.9480502597;10590.735231619272;10866.185036122164;10570.735731606464;10789.514471848943;10873.401962892116;10873.454538185424;10876.456177191267 23:46:17 INFO - PROCESS | 2313 | __end_tp_report 23:46:17 INFO - PROCESS | 2313 | __start_cc_report 23:46:17 INFO - PROCESS | 2313 | _x_x_mozilla_cycle_collect,313 23:46:17 INFO - PROCESS | 2313 | __end_cc_report 23:46:17 INFO - PROCESS | 2313 | __startTimestamp1476945977387__endTimestamp 23:46:17 INFO - PROCESS | 2313 | 23:46:17 INFO - PROCESS | 2313 | ------- Summary: start ------- 23:46:17 INFO - PROCESS | 2313 | Number of tests: 6 23:46:17 INFO - PROCESS | 2313 | 23:46:17 INFO - PROCESS | 2313 | [#0] dojo.html Cycles:165 Average:5395.91 Median:5647.69 stddev:632.53 (11.2%) stddev-sans-first:607.62 23:46:17 INFO - PROCESS | 2313 | Values: 3071.4 3077.5 3080.0 3080.2 3092.2 5332.3 5399.2 5403.2 5410.1 5553.9 5330.3 5422.3 5496.9 5505.6 5552.6 4888.7 4960.6 4962.8 4986.2 5054.4 4928.7 4993.4 5017.6 5044.4 5077.4 4768.8 4939.6 4982.1 5013.7 5018.9 4848.2 4880.6 4907.8 4923.0 4994.5 4854.9 4857.3 4876.4 4881.0 4933.3 5352.8 5380.5 5387.8 5407.3 5436.3 5663.8 5704.2 5780.3 5809.3 5811.2 5875.3 5876.0 5891.4 5895.0 5948.8 5435.1 5456.5 5458.4 5460.4 5470.6 5765.6 5865.4 5904.4 5918.1 5934.5 5741.6 5749.9 5750.5 5776.8 5808.8 5780.2 5789.1 5835.9 5847.1 5855.5 5596.8 5668.7 5737.0 5739.3 5754.9 5751.7 5771.0 5772.9 5782.4 5833.4 4364.4 4365.7 4369.6 4376.3 4417.6 3841.9 3873.7 3885.6 3907.3 3938.4 5582.8 5588.5 5589.3 5604.4 5615.4 5855.3 5855.4 5873.7 5887.1 5890.5 5405.2 5426.7 5512.2 5568.3 5589.5 4856.6 4901.8 4940.3 4945.9 4987.5 6001.7 6032.5 6074.5 6084.8 6098.1 5658.5 5709.2 5854.5 5869.8 5891.0 5949.6 5987.3 6001.3 6033.9 6086.3 5696.3 5710.2 5728.1 5745.2 5749.4 5647.7 5836.1 5839.0 5847.3 5851.6 5567.9 5585.9 5663.5 5666.3 5756.7 5661.7 5663.5 5663.6 5676.4 5678.4 5472.8 5622.5 5625.4 5659.1 5662.9 5736.6 5765.1 5765.6 5810.1 5863.6 5627.4 5663.3 5669.3 5677.7 5684.3 23:46:17 INFO - PROCESS | 2313 | 23:46:17 INFO - PROCESS | 2313 | [#1] ext.html Cycles:180 Average:58458.84 Median:41369.90 stddev:113816.63 (275.1%) stddev-sans-first:114052.89 23:46:17 INFO - PROCESS | 2313 | Values: 557.3 575.3 582.8 584.4 595.7 40596.4 41004.0 42265.2 45843.0 46104.3 43400.3 43555.1 43884.3 43891.3 43892.8 8706.3 8865.3 8868.3 8869.2 8878.8 8727.3 8815.6 8830.9 8832.1 8839.6 8846.8 8899.6 8905.2 8907.7 8928.5 8781.5 8786.6 8790.0 8834.4 8846.6 8638.3 8700.9 8786.2 8787.5 8808.5 39753.0 40249.8 40260.6 40283.0 40472.0 3478.4 3487.5 3555.7 3569.8 3600.8 30971.7 31390.2 31447.2 31478.4 31490.2 4155.7 4294.1 4329.0 4366.6 4382.1 330816.0 330996.0 332760.0 332895.3 333195.0 54159.7 54204.5 54289.7 54618.7 54667.5 56058.0 56573.7 56611.2 56691.7 57026.7 15684.9 16035.0 16087.1 16092.9 16093.7 12296.8 12417.5 12527.2 12539.7 12540.9 14625.6 15172.6 15298.8 15314.4 15462.3 5991.5 6079.1 6316.7 6356.8 6454.0 924.3 1005.2 1006.2 1101.3 1110.7 31618.8 31697.5 31755.0 31847.8 31923.7 987.6 1036.7 1076.6 1152.6 1157.7 15928.8 16487.4 16559.3 16647.3 16828.2 500471.0 503908.9 504514.0 505590.0 507232.0 57260.4 57572.4 57604.0 57708.4 57779.4 1265.8 1288.3 1323.7 1328.6 1331.1 28736.6 30145.2 30888.4 30972.4 31124.5 48642.8 48857.3 48889.3 48988.0 49001.9 432504.0 434336.0 435015.0 437658.0 438644.0 38282.0 38717.0 39259.0 39635.6 39770.0 45953.0 46483.8 46643.5 47371.0 47944.0 38843.0 40053.2 40324.2 41581.4 42005.8 40016.0 40407.2 41298.8 41441.0 42161.2 39680.8 39857.0 39941.2 40001.4 40118.4 34107.3 36667.8 36969.3 37045.4 37188.4 27838.0 28046.6 28164.9 28225.4 28333.0 23:46:17 INFO - PROCESS | 2313 | 23:46:17 INFO - PROCESS | 2313 | [#2] jquery.html Cycles:180 Average:28817.61 Median:391.20 stddev:73021.12 (18665.9%) stddev-sans-first:73194.74 23:46:17 INFO - PROCESS | 2313 | Values: 374.4 387.3 389.3 393.1 399.7 18393.3 20181.3 20339.8 20352.4 20380.0 18827.1 19000.0 19222.9 19241.5 19319.4 4965.8 5589.2 5847.3 5847.8 6376.1 6503.5 6558.8 6562.5 6570.9 6578.8 6159.6 6462.9 6473.4 6530.9 6577.5 5940.4 6137.1 6516.5 6555.4 6576.8 5767.7 5769.0 5780.9 5785.7 5787.2 13546.4 14002.8 14009.4 14015.7 14016.3 2223.4 2231.3 2231.4 2272.2 3033.8 15142.2 15215.7 15307.0 16090.6 16844.3 1999.1 2001.1 2029.4 2068.5 2116.6 93799.2 94135.5 95377.5 98132.0 101994.0 17080.7 17778.8 17790.8 17991.9 18055.5 31540.7 31594.4 31640.2 31649.8 31950.7 9604.3 9654.2 9675.9 9824.2 9970.5 7931.6 8039.2 8142.8 8384.7 8389.7 8524.7 8608.2 8723.5 8846.7 9070.8 3236.4 3311.9 3339.2 3391.6 3402.6 891.4 974.9 986.3 1016.9 1017.7 18697.6 19433.6 19717.6 19782.8 20037.5 894.5 958.2 965.4 968.2 1023.9 10952.6 11069.4 11115.2 11248.5 11279.8 424975.0 428641.0 447645.0 447729.0 449402.0 90169.5 91621.5 91892.0 91938.0 92622.0 932.4 947.6 967.7 974.2 976.8 16863.3 17269.8 17710.9 17747.5 17784.8 41535.6 42514.6 42684.0 42866.6 42928.6 54664.2 55897.0 56419.4 56718.1 57184.7 7991.4 8276.8 8416.2 8802.8 8809.1 12282.9 13132.3 13520.6 13585.9 13779.0 10487.6 10912.0 10961.7 11352.9 11586.7 11597.6 11905.8 11978.5 12000.9 12347.9 11867.5 11940.0 11948.9 12057.5 12557.4 8137.6 8169.7 8282.7 8335.6 8381.2 8498.0 11000.9 11208.7 11557.4 11838.2 23:46:17 INFO - PROCESS | 2313 | 23:46:17 INFO - PROCESS | 2313 | [#3] mootools.html Cycles:180 Average:5797.64 Median:4796.40 stddev:3307.66 (69.0%) stddev-sans-first:3300.83 23:46:17 INFO - PROCESS | 2313 | Values: 1454.4 1476.4 1621.5 1725.6 1757.3 8037.4 8307.0 8379.8 8928.5 8962.0 8508.7 8832.4 8846.1 9018.0 9058.9 2293.0 2318.1 2330.3 2330.9 2333.7 2259.1 2273.7 2330.3 2364.8 2374.2 2304.8 2310.7 2327.0 2337.7 2359.3 2252.7 2259.6 2265.5 2270.9 2274.1 2209.1 2221.0 2228.5 2228.8 2231.3 8963.1 8998.5 9014.4 9016.9 9053.2 5217.4 5371.8 5375.8 5390.6 5399.6 3326.8 3362.7 3518.4 3536.5 3548.6 1073.7 1095.5 1107.1 1109.9 1138.2 12239.4 12243.0 12288.6 12337.4 12339.4 4410.2 4533.6 4639.5 4667.8 4745.5 10299.1 10374.1 10375.1 10389.3 10439.1 5408.4 5410.6 5435.8 5446.2 5449.8 4244.1 4375.1 4688.1 4781.5 5011.1 3873.6 3900.8 3960.1 3997.3 4008.2 1249.2 1249.6 1254.0 1271.0 1272.5 766.9 939.7 940.2 955.6 962.8 5735.7 5769.6 5918.9 5946.3 6441.7 904.7 927.3 951.9 955.6 976.7 3791.4 4091.5 4171.1 4182.7 4277.5 10571.9 10752.4 10866.1 10956.5 11128.9 11049.7 11102.6 11111.4 11113.2 11124.8 7856.5 8245.6 8293.3 8320.8 8333.2 5972.3 5993.2 6017.5 6027.7 6167.5 9872.4 9888.4 10011.9 10046.2 10063.2 9732.4 10032.8 10033.5 10248.1 10356.7 7128.6 7381.7 7569.4 7832.4 8025.3 8356.4 8808.4 8821.0 8825.1 8834.2 7704.4 7721.2 7729.4 7858.8 7990.8 7466.6 7523.3 7691.1 7726.7 7779.5 6710.3 6820.6 6839.9 6844.8 6849.4 4811.3 4845.1 4927.5 5017.7 5115.1 5107.0 5117.9 5122.0 5171.8 5171.8 23:46:17 INFO - PROCESS | 2313 | 23:46:17 INFO - PROCESS | 2313 | [#4] prototype.html Cycles:180 Average:4726.58 Median:5259.58 stddev:1387.34 (26.4%) stddev-sans-first:1351.25 23:46:17 INFO - PROCESS | 2313 | Values: 321.3 326.2 330.4 335.7 341.4 5431.9 5601.8 5621.7 5628.1 5644.5 5459.4 5541.8 5565.5 5568.3 5597.9 4306.7 4349.8 4354.9 4367.0 4372.8 4191.6 4268.9 4293.3 4312.4 4328.8 4271.9 4273.4 4279.2 4286.8 4290.9 4213.2 4274.5 4279.1 4284.7 4289.3 3690.5 3760.9 3768.6 3777.5 3788.8 5325.9 5327.9 5336.0 5357.9 5413.4 4904.9 4906.5 4916.3 4920.9 4926.5 5666.8 5772.0 5780.5 5851.3 5860.4 4109.0 4109.9 4113.4 4115.9 4134.3 5981.3 6030.2 6126.6 6129.6 6136.1 4065.6 4222.6 4232.5 4233.8 4243.8 4248.8 4270.0 4273.8 4279.4 4283.8 4879.2 4936.3 4953.3 4968.5 4990.8 5648.8 5832.8 5895.7 5905.6 5930.6 1419.7 1452.8 1461.1 1467.8 1475.8 902.5 921.2 936.2 944.6 945.5 4934.6 4949.4 4952.8 4973.0 4976.9 5199.1 5227.3 5236.9 5263.3 5272.0 4780.8 4838.9 4926.0 4930.3 4951.0 2737.7 2760.9 2794.4 2805.6 2821.5 5347.9 5351.8 5353.2 5379.7 5394.6 4921.8 5193.8 5208.0 5214.3 5280.8 5271.8 5288.7 5303.7 5338.7 5370.8 5225.2 5230.5 5256.9 5262.3 5269.6 5190.5 5490.1 5866.9 5900.1 5906.9 6149.8 6191.7 6201.0 6270.5 6273.4 4033.7 4225.6 4230.7 4276.5 4291.3 5819.3 5926.0 5938.4 5951.7 5987.5 5763.4 5773.8 5825.2 5827.9 5856.6 5755.4 5766.3 5767.2 5770.5 5778.7 5680.7 5737.7 5780.0 5813.4 5842.7 5820.4 5824.8 5834.4 5860.9 5862.9 5608.4 5669.9 5705.7 5732.7 5738.9 23:46:17 INFO - PROCESS | 2313 | 23:46:17 INFO - PROCESS | 2313 | [#5] yui.html Cycles:180 Average:18883.89 Median:26555.68 stddev:26141.84 (98.4%) stddev-sans-first:26179.68 23:46:17 INFO - PROCESS | 2313 | Values: 740.5 788.3 788.4 820.2 864.7 15534.5 16495.1 16552.8 16596.1 16642.3 13973.2 14054.8 14062.0 14094.6 14183.4 769.8 790.6 813.8 814.5 821.1 807.1 812.0 814.1 814.3 814.5 841.6 847.3 847.5 849.9 850.4 836.0 842.5 843.8 845.2 845.5 613.6 613.6 614.8 615.2 616.8 13858.2 13865.7 13898.5 13902.6 13930.8 14151.3 14153.6 14177.8 14406.5 14613.8 12081.8 12195.0 12255.9 12399.6 12580.1 3579.4 3604.7 3658.7 3687.3 3707.3 84329.0 84706.2 84745.6 85389.0 88675.6 10825.9 11022.6 11048.2 11249.0 11356.1 20400.4 20646.0 20815.6 20816.5 20897.3 8257.7 8291.2 8302.4 8440.5 8525.2 4577.5 4608.1 4621.3 4665.3 4685.7 3488.8 3544.6 3582.2 3607.0 3608.6 628.1 636.8 639.2 643.9 655.9 575.2 629.1 650.2 664.5 675.7 8900.0 9268.5 9317.5 9594.9 9984.7 581.7 601.1 686.4 687.7 777.4 4404.4 4573.5 4621.4 4659.1 4808.4 64546.4 65993.3 66310.7 74612.0 110421.4 86396.6 89638.6 90015.5 91310.5 92887.5 53154.7 55000.0 71439.6 81601.2 84799.6 8747.7 8860.0 8871.5 9168.1 9200.9 48303.0 48493.8 48676.8 49619.8 49939.8 66844.3 73967.3 74346.6 74651.0 80245.6 11660.7 11764.7 11890.8 12161.6 12253.6 13073.3 13141.3 13201.6 13263.6 13817.4 11892.9 12412.4 12500.2 12710.7 13450.1 12078.7 12155.6 12481.3 12498.7 12731.0 11015.6 11211.3 11505.4 11632.8 11886.5 10350.4 10375.0 10389.9 10590.7 10866.2 10570.7 10789.5 10873.4 10873.5 10876.5 23:46:17 INFO - PROCESS | 2313 | -------- Summary: end -------- 23:46:17 INFO - PROCESS | 2313 | 23:46:18 INFO - TEST-INFO | 2313: exit 0 23:46:18 INFO - TEST-OK | dromaeo_css | took 1115989ms 23:46:18 INFO - TEST-START | kraken 23:46:18 INFO - operating with platform_type : linux_ 23:46:18 INFO - Initialising browser for kraken test... 23:46:18 INFO - TEST-INFO | started process 2825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZqYfkl/profile http://localhost:36382/getInfo.html) 23:46:22 INFO - PROCESS | 2825 | __metrics Screen width/height:1600/1200 23:46:22 INFO - PROCESS | 2825 | colorDepth:24 23:46:22 INFO - PROCESS | 2825 | Browser inner width/height: 1024/697 23:46:22 INFO - PROCESS | 2825 | __metrics 23:46:23 ERROR - PROCESS | 2825 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 23:46:24 INFO - TEST-INFO | 2825: exit 0 23:46:24 INFO - Browser initialized. 23:46:24 INFO - Running cycle 1/1 for kraken test... 23:46:24 INFO - TEST-INFO | started process 2988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZqYfkl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:46:36 INFO - PROCESS | 2988 | RSS: Main: 182231040 23:46:36 INFO - PROCESS | 2988 | 23:46:39 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:36382/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36382/tests/kraken/driver.html?testName=audio-beat-detection) 23:46:40 INFO - PROCESS | 2988 | RSS: Main: 196231168 23:46:40 INFO - PROCESS | 2988 | 23:46:43 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:36382/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36382/tests/kraken/driver.html?testName=audio-dft) 23:46:43 INFO - PROCESS | 2988 | RSS: Main: 194002944 23:46:43 INFO - PROCESS | 2988 | 23:46:46 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:36382/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36382/tests/kraken/driver.html?testName=audio-fft) 23:46:47 INFO - PROCESS | 2988 | RSS: Main: 190640128 23:46:47 INFO - PROCESS | 2988 | 23:46:49 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:36382/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36382/tests/kraken/driver.html?testName=audio-oscillator) 23:46:50 INFO - PROCESS | 2988 | RSS: Main: 191438848 23:46:50 INFO - PROCESS | 2988 | 23:46:52 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:36382/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36382/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:46:52 INFO - PROCESS | 2988 | RSS: Main: 191905792 23:46:52 INFO - PROCESS | 2988 | 23:46:55 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:36382/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36382/tests/kraken/driver.html?testName=imaging-darkroom) 23:46:56 INFO - PROCESS | 2988 | RSS: Main: 191651840 23:46:56 INFO - PROCESS | 2988 | 23:46:59 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:36382/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36382/tests/kraken/driver.html?testName=imaging-desaturate) 23:47:00 INFO - PROCESS | 2988 | RSS: Main: 192372736 23:47:00 INFO - PROCESS | 2988 | 23:47:03 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:36382/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36382/tests/kraken/driver.html?testName=json-parse-financial) 23:47:03 INFO - PROCESS | 2988 | RSS: Main: 192503808 23:47:03 INFO - PROCESS | 2988 | 23:47:05 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:36382/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36382/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:47:06 INFO - PROCESS | 2988 | RSS: Main: 192122880 23:47:06 INFO - PROCESS | 2988 | 23:47:07 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:36382/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36382/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:47:08 INFO - PROCESS | 2988 | RSS: Main: 191778816 23:47:08 INFO - PROCESS | 2988 | 23:47:10 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:36382/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36382/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:47:11 INFO - PROCESS | 2988 | RSS: Main: 191922176 23:47:11 INFO - PROCESS | 2988 | 23:47:14 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:36382/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36382/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:47:14 INFO - PROCESS | 2988 | RSS: Main: 191725568 23:47:14 INFO - PROCESS | 2988 | 23:47:17 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:36382/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36382/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:47:18 INFO - PROCESS | 2988 | RSS: Main: 192675840 23:47:18 INFO - PROCESS | 2988 | 23:47:20 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:36382/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36382/tests/kraken/driver.html?testName=ai-astar) 23:47:20 INFO - PROCESS | 2988 | RSS: Main: 193888256 23:47:20 INFO - PROCESS | 2988 | 23:47:20 INFO - PROCESS | 2988 | __start_tp_report 23:47:20 INFO - PROCESS | 2988 | _x_x_mozilla_page_load 23:47:20 INFO - PROCESS | 2988 | _x_x_mozilla_page_load_details 23:47:20 INFO - PROCESS | 2988 | |i|pagename|runs| 23:47:20 INFO - PROCESS | 2988 | |0;ai-astar;108;112;111;113;110;113;111;112;112;112 23:47:20 INFO - PROCESS | 2988 | |1;audio-beat-detection;148;125;124;176;130;127;127;127;160;129 23:47:20 INFO - PROCESS | 2988 | |2;audio-dft;162;166;169;166;163;163;164;166;163;161 23:47:20 INFO - PROCESS | 2988 | |3;audio-fft;75;76;76;118;80;76;76;77;112;77 23:47:20 INFO - PROCESS | 2988 | |4;audio-oscillator;83;84;109;84;84;83;106;87;83;107 23:47:20 INFO - PROCESS | 2988 | |5;imaging-gaussian-blur;119;119;119;119;118;118;119;117;117;117 23:47:20 INFO - PROCESS | 2988 | |6;imaging-darkroom;148;147;148;148;155;147;147;147;148;147 23:47:20 INFO - PROCESS | 2988 | |7;imaging-desaturate;87;85;85;86;85;87;85;85;86;85 23:47:20 INFO - PROCESS | 2988 | |8;json-parse-financial;57;54;56;55;56;57;59;56;56;57 23:47:20 INFO - PROCESS | 2988 | |9;json-stringify-tinderbox;59;62;61;60;61;60;61;59;60;61 23:47:20 INFO - PROCESS | 2988 | |10;stanford-crypto-aes;80;81;81;82;81;82;81;80;82;81 23:47:20 INFO - PROCESS | 2988 | |11;stanford-crypto-ccm;132;144;135;137;133;136;134;130;231;137 23:47:20 INFO - PROCESS | 2988 | |12;stanford-crypto-pbkdf2;169;168;168;169;168;167;170;169;168;166 23:47:20 INFO - PROCESS | 2988 | |13;stanford-crypto-sha256-iterative;67;71;67;66;69;67;65;65;73;67 23:47:20 INFO - PROCESS | 2988 | __end_tp_report 23:47:20 INFO - PROCESS | 2988 | __start_cc_report 23:47:20 INFO - PROCESS | 2988 | _x_x_mozilla_cycle_collect,801 23:47:20 INFO - PROCESS | 2988 | __end_cc_report 23:47:20 INFO - PROCESS | 2988 | __startTimestamp1476946040255__endTimestamp 23:47:20 INFO - PROCESS | 2988 | 23:47:20 INFO - PROCESS | 2988 | ------- Summary: start ------- 23:47:20 INFO - PROCESS | 2988 | Number of tests: 14 23:47:20 INFO - PROCESS | 2988 | 23:47:20 INFO - PROCESS | 2988 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:1.51 (1.3%) stddev-sans-first:0.97 23:47:20 INFO - PROCESS | 2988 | Values: 108.0 112.0 111.0 113.0 110.0 113.0 111.0 112.0 112.0 112.0 23:47:20 INFO - PROCESS | 2988 | 23:47:20 INFO - PROCESS | 2988 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:129.50 stddev:17.94 (13.9%) stddev-sans-first:18.60 23:47:20 INFO - PROCESS | 2988 | Values: 148.0 125.0 124.0 176.0 130.0 127.0 127.0 127.0 160.0 129.0 23:47:20 INFO - PROCESS | 2988 | 23:47:20 INFO - PROCESS | 2988 | [#2] audio-dft Cycles:10 Average:164.30 Median:165.00 stddev:2.41 (1.5%) stddev-sans-first:2.40 23:47:20 INFO - PROCESS | 2988 | Values: 162.0 166.0 169.0 166.0 163.0 163.0 164.0 166.0 163.0 161.0 23:47:20 INFO - PROCESS | 2988 | 23:47:20 INFO - PROCESS | 2988 | [#3] audio-fft Cycles:10 Average:84.30 Median:76.00 stddev:16.30 (21.4%) stddev-sans-first:16.93 23:47:20 INFO - PROCESS | 2988 | Values: 75.0 76.0 76.0 118.0 80.0 76.0 76.0 77.0 112.0 77.0 23:47:20 INFO - PROCESS | 2988 | 23:47:20 INFO - PROCESS | 2988 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:83.50 stddev:11.35 (13.6%) stddev-sans-first:11.67 23:47:20 INFO - PROCESS | 2988 | Values: 83.0 84.0 109.0 84.0 84.0 83.0 106.0 87.0 83.0 107.0 23:47:20 INFO - PROCESS | 2988 | 23:47:20 INFO - PROCESS | 2988 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:119.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 23:47:20 INFO - PROCESS | 2988 | Values: 119.0 119.0 119.0 119.0 118.0 118.0 119.0 117.0 117.0 117.0 23:47:20 INFO - PROCESS | 2988 | 23:47:20 INFO - PROCESS | 2988 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:2.44 (1.6%) stddev-sans-first:2.59 23:47:20 INFO - PROCESS | 2988 | Values: 148.0 147.0 148.0 148.0 155.0 147.0 147.0 147.0 148.0 147.0 23:47:20 INFO - PROCESS | 2988 | 23:47:20 INFO - PROCESS | 2988 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:85.50 stddev:0.84 (1.0%) stddev-sans-first:0.73 23:47:20 INFO - PROCESS | 2988 | Values: 87.0 85.0 85.0 86.0 85.0 87.0 85.0 85.0 86.0 85.0 23:47:20 INFO - PROCESS | 2988 | 23:47:20 INFO - PROCESS | 2988 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.50 stddev:1.34 (2.4%) stddev-sans-first:1.39 23:47:20 INFO - PROCESS | 2988 | Values: 57.0 54.0 56.0 55.0 56.0 57.0 59.0 56.0 56.0 57.0 23:47:20 INFO - PROCESS | 2988 | 23:47:20 INFO - PROCESS | 2988 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:61.00 stddev:0.97 (1.6%) stddev-sans-first:0.88 23:47:20 INFO - PROCESS | 2988 | Values: 59.0 62.0 61.0 60.0 61.0 60.0 61.0 59.0 60.0 61.0 23:47:20 INFO - PROCESS | 2988 | 23:47:20 INFO - PROCESS | 2988 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.00 stddev:0.74 (0.9%) stddev-sans-first:0.67 23:47:20 INFO - PROCESS | 2988 | Values: 80.0 81.0 81.0 82.0 81.0 82.0 81.0 80.0 82.0 81.0 23:47:20 INFO - PROCESS | 2988 | 23:47:20 INFO - PROCESS | 2988 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:136.50 stddev:30.49 (22.3%) stddev-sans-first:31.98 23:47:20 INFO - PROCESS | 2988 | Values: 132.0 144.0 135.0 137.0 133.0 136.0 134.0 130.0 231.0 137.0 23:47:20 INFO - PROCESS | 2988 | 23:47:20 INFO - PROCESS | 2988 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:168.50 stddev:1.14 (0.7%) stddev-sans-first:1.17 23:47:20 INFO - PROCESS | 2988 | Values: 169.0 168.0 168.0 169.0 168.0 167.0 170.0 169.0 168.0 166.0 23:47:20 INFO - PROCESS | 2988 | 23:47:20 INFO - PROCESS | 2988 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.00 stddev:2.58 (3.9%) stddev-sans-first:2.73 23:47:20 INFO - PROCESS | 2988 | Values: 67.0 71.0 67.0 66.0 69.0 67.0 65.0 65.0 73.0 67.0 23:47:20 INFO - PROCESS | 2988 | -------- Summary: end -------- 23:47:20 INFO - PROCESS | 2988 | 23:47:21 INFO - TEST-INFO | 2988: exit 0 23:47:21 INFO - TEST-OK | kraken | took 63021ms 23:47:21 INFO - SUITE-END | took 1179s 23:47:21 INFO - Completed test suite (00:19:39) 23:47:21 INFO - javascript benchmark 23:47:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7290.850017979998, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3071.447139514888, 3077.5383692446135, 3079.9846000769994, 3080.199148221463, 3092.180572148381, 5332.306800115989, 5399.163129714891, 5403.2165336026255, 5410.05324068288, 5553.944460555394, 5330.333708286465, 5422.267993820833, 5496.917546236809, 5505.559555235582, 5552.583556233279, 4888.706677599338, 4960.578350840165, 4962.751862406865, 4986.248775320398, 5054.368203974504, 4928.728919909404, 4993.350864387643, 5017.573506251954, 5044.369453818273, 5077.41609714882, 4768.809247630125, 4939.580135688435, 4982.103221420143, 5013.724245166514, 5018.949810501903, 4848.248521479177, 4880.585150262232, 4907.828226012072, 4922.975385123087, 4994.525520075587, 4854.902901941941, 4857.344258525124, 4876.390451193601, 4880.951190488121, 4933.309336692866, 5352.785888564492, 5380.488853558905, 5387.81142660005, 5407.297051383334, 5436.320459942507, 5663.801766938179, 5704.201411802351, 5780.306363236438, 5809.302883653946, 5811.215485909391, 5875.324337701177, 5876.0, 5891.440313170242, 5895.0, 5948.7620495180145, 5435.103207970719, 5456.536194423518, 5458.399576046631, 5460.426655201187, 5470.56235501159, 5765.625234359753, 5865.35481097079, 5904.380040095814, 5918.112283157475, 5934.525237980951, 5741.569382296261, 5749.913751293734, 5750.539956803445, 5776.797812076641, 5808.796692115756, 5780.1907732917425, 5789.131630255495, 5835.94164058354, 5847.06446968483, 5855.4730074292665, 5596.804111856066, 5668.716564171775, 5736.971315143398, 5739.253896993364, 5754.913676294859, 5751.683657398883, 5770.971145144247, 5772.942270577324, 5782.392848750905, 5833.358330583633, 4364.367166760802, 4365.738055716667, 4369.584889435499, 4376.277914144131, 4417.646588272931, 3841.9039524012123, 3873.7288389813007, 3885.592012838668, 3907.277153726513, 3938.3895496198134, 5582.7766889323975, 5588.469095435927, 5589.329280486287, 5604.439556044363, 5615.354234263112, 5855.2973643163095, 5855.443732845458, 5873.706314684248, 5887.087501437284, 5890.49930755882, 5405.189221616789, 5426.701531415731, 5512.173174023848, 5568.303962004749, 5589.496945274945, 4856.562909338177, 4901.779419926112, 4940.333055037524, 4945.876353091202, 4987.451380348159, 6001.669908155093, 6032.54755893301, 6074.453299203093, 6084.847878802977, 6098.054801505774, 5658.462446067617, 5709.22925405065, 5854.4730974212525, 5869.765209391577, 5890.970545147246, 5949.583529152917, 5987.2815262168815, 6001.339852616122, 6033.909491357721, 6086.3305036446845, 5696.316442026983, 5710.172025056427, 5728.083506638918, 5745.166950792195, 5749.396313387034, 5647.6893770843, 5836.124581312667, 5838.970805145947, 5847.26909136358, 5851.64890106595, 5567.944320556742, 5585.916211256916, 5663.5469162467725, 5666.263385759989, 5756.71216439168, 5661.745221464962, 5663.5469162467725, 5663.57523185771, 5676.375598684224, 5678.432156784289, 5472.781088756406, 5622.522085622768, 5625.381208067028, 5659.094544872801, 5662.867426514796, 5736.627119237236, 5765.077587586134, 5765.596408251382, 5810.070388737781, 5863.618864773776, 5627.437256274504, 5663.263775709296, 5669.34802497718, 5677.659340439587, 5684.289463817023], "value": 5351.3626516078875, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.292238856652, 575.2550447170913, 582.839719077254, 584.3513699793232, 595.7021489255371, 40596.391054134176, 41004.0, 42265.15469690608, 45843.0, 46104.308435373496, 43400.34899476502, 43555.12889742203, 43884.341734873924, 43891.34162987558, 43892.78053609728, 8706.347023973196, 8865.290776737878, 8868.334874884376, 8869.157430044135, 8878.778030549223, 8727.301815854747, 8815.559222038904, 8830.911690883106, 8832.072632373605, 8839.60221790021, 8846.778830529256, 8899.599518021672, 8905.198532132139, 8907.68823091192, 8928.508932008737, 8781.473111613324, 8786.638071098925, 8789.95605021974, 8834.425762325429, 8846.5576721164, 8638.265747411477, 8700.869486957701, 8786.209241168326, 8787.516686582236, 8808.471491710454, 39753.0, 40249.798751006354, 40260.59739402627, 40283.0, 40472.0, 3478.3912815257227, 3487.511748355232, 3555.6622120898473, 3569.803660798655, 3600.7757362496877, 30971.69028309733, 31390.215244618837, 31447.213819654462, 31478.37043259122, 31490.212744681565, 4155.729877557949, 4294.098239369736, 4328.956710432918, 4366.628836548865, 4382.123575284956, 330816.0, 330996.0, 332760.0, 332895.3355233233, 333195.0, 54159.729201353744, 54204.45795542073, 54289.72855135699, 54618.726906366006, 54667.45332546624, 56058.0, 56573.7171314149, 56611.15083273754, 56691.71654141703, 57026.714866426235, 15684.921575392278, 16035.037897726173, 16087.115208663401, 16092.919535402249, 16093.678126437406, 12296.815547766791, 12417.503299868085, 12527.248365098123, 12539.686507837378, 12540.937295313464, 14625.561233163022, 15172.620684482976, 15298.847011529964, 15314.387424502895, 15462.304196311194, 5991.5206783457215, 6079.148919151322, 6316.684165791784, 6356.809295721136, 6454.0, 924.2605915267759, 1005.1556692378291, 1006.2050979726081, 1101.3061771084165, 1110.7278716714295, 31618.841905790785, 31697.52453713196, 31755.0, 31847.840760796047, 31923.669680843086, 987.5852142100335, 1036.7149034015706, 1076.6447072466224, 1152.5850693750244, 1157.7279339355246, 15928.76106858398, 16487.422940197277, 16559.25483353252, 16647.250873710713, 16828.24272907722, 500471.0, 503908.92182156886, 504514.0, 505590.0, 507232.0, 57260.42739572634, 57572.424275756704, 57603.99999999916, 57708.422915771145, 57779.422205778246, 1265.8417697787777, 1288.2656885575132, 1323.67569945364, 1328.6279841644355, 1331.1281110872587, 28736.568951465328, 30145.24636884008, 30888.38223235478, 30972.380552388375, 31124.53313200349, 48642.75678621584, 48857.267140992204, 48889.266661000824, 48988.0, 49001.93464209133, 432504.0, 434336.0, 435015.0, 437658.0, 438644.0, 38282.0, 38717.0, 39259.0, 39635.60364396434, 39770.0, 45953.0, 46483.767581161876, 46643.533564665275, 47371.0, 47944.0, 38843.02872999192, 40053.1989360217, 40324.19351612893, 41581.37627935644, 42005.78997104995, 40016.0, 40407.1918561633, 41298.79350603228, 41441.0, 42161.156776864904, 39680.83351248193, 39857.0, 39941.2011759769, 40001.399978999754, 40118.39822402608, 34107.31785364328, 36667.81666091653, 36969.26061478702, 37045.44431833579, 37188.39681222288, 27838.0, 28046.57930131009, 28164.85917570399, 28225.43549129047, 28333.0], "value": 19685.71523159084, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.3561074951083, 387.33765261403, 389.29731834039546, 393.1037235103964, 399.73217943977534, 18393.264269429223, 20181.29365472209, 20339.796602033974, 20352.389428317154, 20380.0, 18827.05864706766, 19000.04999750014, 19222.903885480588, 19241.518962025923, 19319.420417387464, 4965.801367945278, 5589.217509548656, 5847.327557330897, 5847.766089356421, 6376.139221205148, 6503.544751867371, 6558.836029099263, 6562.540622156451, 6570.93429065708, 6578.80263592093, 6159.568830181889, 6462.870742585145, 6473.44975677068, 6530.869382612344, 6577.539572229945, 5940.435658612425, 6137.110119032715, 6516.543841931067, 6555.410013098844, 6576.80269591913, 5767.711614419304, 5768.97115514424, 5780.942190578083, 5785.681787501686, 5787.160861675034, 13546.390412431365, 14002.789958150635, 14009.439622415091, 14015.719685606231, 14016.299185040809, 2223.3663405929397, 2231.3306008197474, 2231.364061242538, 2272.2388000020014, 3033.8179709217516, 15142.242887855673, 15215.695686086216, 15307.0, 16090.5977350566, 16844.32622695103, 1999.1403696410537, 2001.0995052226556, 2029.401326608654, 2068.4621998280404, 2116.608427440913, 93799.23950592779, 94135.52932235294, 95377.52311238469, 98132.0, 101994.0, 17080.743788843178, 17778.822211777977, 17790.822091779177, 17991.851426000398, 18055.458336249932, 31540.684593154234, 31594.368112637618, 31640.208994775316, 31649.84175079156, 31950.680493195236, 9604.327697061139, 9654.22766178704, 9675.90324096764, 9824.164945979672, 9970.45162516054, 7931.603419829101, 8039.196080391914, 8142.806454675847, 8384.664613415394, 8389.74153876911, 8524.717983576367, 8608.225259726654, 8723.476591404537, 8846.690365837165, 9070.825211176167, 3236.449803533405, 3311.850966706504, 3339.215284408162, 3391.559097317333, 3402.557667503209, 891.3715830339595, 974.8878878928872, 986.2800155886243, 1016.9491525423699, 1017.7048655889857, 18697.626047478974, 19433.611327773364, 19717.60564788725, 19782.802171978095, 20037.49906252326, 894.4677916639589, 958.2184897362251, 965.4255717847869, 968.2350942755286, 1023.9129673977795, 10952.56189752401, 11069.446527673585, 11115.166362522843, 11248.493817778219, 11279.830802537968, 424975.0, 428641.0, 447645.0, 447729.0, 449402.0, 90169.54915225513, 91621.54189229012, 91892.0, 91938.0, 92622.0, 932.4032619123766, 947.5877993072897, 967.7048500207363, 974.1670871404989, 976.8095221431895, 16863.325466981183, 17269.827301727324, 17710.90059239602, 17747.46757597274, 17784.79790452546, 41535.58464415317, 42514.57485425106, 42684.0, 42866.5713342875, 42928.57071429246, 54664.18003730027, 55897.0, 56419.43580564142, 56718.14922776244, 57184.71407642935, 7991.440599158003, 8276.793080173044, 8416.242538171595, 8802.823943521222, 8809.075047120217, 12282.87717122853, 13132.277724725232, 13520.594382168158, 13585.932070339584, 13779.035467517579, 10487.580496780043, 10912.0, 10961.671149865517, 11352.94323528377, 11586.71033224176, 11597.594084207012, 11905.761884762083, 11978.46096925658, 12000.939995300318, 12347.876521234673, 11867.525298987945, 11940.0, 11948.880511194777, 12057.457414416196, 12557.372131393577, 8137.593120344078, 8169.673213071411, 8282.668693252443, 8335.624896879775, 8381.16188381157, 8497.957510212409, 11000.944995274973, 11208.71978200519, 11557.364344961108, 11838.230515016496], "value": 9984.803691510106, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1454.403694485261, 1476.4094362255096, 1621.5135459362195, 1725.6031112844037, 1757.3322137587722, 8037.397195210368, 8306.958465207674, 8379.832403351944, 8928.464292142467, 8961.955190224056, 8508.74473765788, 8832.425892316995, 8846.071162527938, 9018.0, 9058.90941090589, 2292.977070229297, 2318.1307009871216, 2330.3475026992382, 2330.88345582721, 2333.731620863597, 2259.0963614554144, 2273.693051438051, 2330.3125577954543, 2364.7871691547757, 2374.192774456693, 2304.76952304769, 2310.7111611048617, 2327.0, 2337.6960995070617, 2359.304005318427, 2252.7409347925036, 2259.6497542880797, 2265.478939843837, 2270.9318720438414, 2274.0556823915563, 2209.1163534586294, 2220.9666854997026, 2228.5320082782637, 2228.765979572154, 2231.252530402301, 8963.10368963105, 8998.505082220476, 9014.36899417041, 9016.909830901672, 9053.230475409599, 5217.42608313089, 5371.75827087782, 5375.838724838261, 5390.568754499631, 5399.595030372738, 3326.7837590556537, 3362.680545348188, 3518.4194607889667, 3536.45184996326, 3548.5919119301093, 1073.7047311989188, 1095.4686976816238, 1107.1032463704344, 1109.938953357565, 1138.1805100327751, 12239.388030598524, 12243.0, 12288.631341059692, 12337.383130843511, 12339.444724987397, 4410.206162890647, 4533.637309015271, 4639.48965613789, 4667.766611669403, 4745.549172828576, 10299.12457441111, 10374.118199953089, 10375.118114960313, 10389.324693894872, 10439.129239459058, 5408.378036525771, 5410.59420543453, 5435.836924892181, 5446.1558458439, 5449.836504904859, 4244.129953359554, 4375.146846364928, 4688.109259240733, 4781.497942716034, 5011.09800235961, 3873.5932727063814, 3900.7659540427667, 3960.1089754805516, 3997.300472417315, 4008.158286759755, 1249.1568191470903, 1249.5564074753513, 1253.993730031344, 1271.0467149637773, 1272.465564462928, 766.9079710434784, 939.7133874168308, 940.2431043010442, 955.5556666150135, 962.8157366439319, 5735.738137609719, 5769.624974376652, 5918.911216331759, 5946.345901950782, 6441.677916104176, 904.674317245791, 927.3369540778376, 951.9095685909828, 955.603424578792, 976.72651657536, 3791.374423220193, 4091.529474110456, 4171.1032128092, 4182.665386769051, 4277.486701595828, 10571.894281057244, 10752.354858708502, 10866.07638350749, 10956.506957186946, 11128.944355278172, 11049.668509944715, 11102.555897764161, 11111.444427778579, 11113.166512511594, 11124.777504450027, 7856.450048496665, 8245.628946697412, 8293.33653307734, 8320.750377488806, 8333.208345207195, 5972.343042265435, 5993.190919226023, 6017.458428741435, 6027.668478233739, 6167.475764559883, 9872.40765554069, 9888.406695598287, 10011.949940250252, 10046.196304295785, 10063.194944404577, 9732.41605503672, 10032.799344012932, 10033.548490317808, 10248.128909042814, 10356.689299320731, 7128.643567821692, 7381.704731810667, 7569.394448444222, 7832.412569057457, 8025.2777250047775, 8356.415050946618, 8808.427452215585, 8821.0, 8825.117488251124, 8834.160754728291, 7704.422168337509, 7721.227877212234, 7729.4202934779, 7858.803529911569, 7990.84018319642, 7466.552006879605, 7523.285287897641, 7691.077070751546, 7726.729564465217, 7779.533228006338, 6710.328967103251, 6820.556663817035, 6839.93160068393, 6844.828879278058, 6849.383555480031, 4811.302361157543, 4845.103655823684, 4927.457979622167, 5017.698938063728, 5115.130427827204, 5106.974465127651, 5117.8720531987, 5122.0, 5171.767270472763, 5171.844844654666], "value": 4627.129422637398, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.3284235946871, 326.2219606239119, 330.3646947609333, 335.7347695320696, 341.375283231686, 5431.945680543194, 5601.775928962837, 5621.662700237988, 5628.127640215763, 5644.463775941284, 5459.372172200198, 5541.833744987657, 5565.471280228382, 5568.303962004749, 5597.8600534986645, 4306.698531102824, 4349.826006959718, 4354.8911277218, 4366.956330436703, 4372.83544645401, 4191.55988621195, 4268.850590229343, 4293.270144075499, 4312.353147027955, 4328.826846926119, 4271.9359209611885, 4273.401723758676, 4279.2083464559, 4286.785660716967, 4290.940348632658, 4213.188329018521, 4274.465691788527, 4279.144171165779, 4284.700070995047, 4289.270823959934, 3690.464882592009, 3760.8871733848027, 3768.5854555998817, 3777.471154038437, 3788.753731007503, 5325.920111198335, 5327.946720532823, 5336.0, 5357.866053348658, 5413.430105269506, 4904.926426103576, 4906.460289368167, 4916.303875163063, 4920.926186107211, 4926.45808961014, 5666.801661941812, 5772.0, 5780.537556995472, 5851.268591426072, 5860.443257890493, 4108.993296642342, 4109.938350924738, 4113.382992551141, 4115.8971025724295, 4134.255833949888, 5981.312149102865, 6030.185924900126, 6126.632402055891, 6129.601575897553, 6136.072913335469, 4065.6137666921595, 4222.619964203236, 4232.470941132358, 4233.7883105844585, 4243.8090285937205, 4248.8300467980935, 4269.957300427018, 4273.807678654468, 4279.358096285582, 4283.800535849967, 4879.194932836113, 4936.308916751657, 4953.25701144824, 4968.453470118284, 4990.800367985313, 5648.774049038075, 5832.825015249549, 5895.675737834375, 5905.586608937419, 5930.644161350333, 1419.7302512522588, 1452.782082687584, 1461.1379286221181, 1467.8238611366705, 1475.8450362711976, 902.4675441489421, 921.1847514949318, 936.166811537732, 944.6032666280179, 945.4988855906244, 4934.631376939089, 4949.430815456269, 4952.752362381939, 4972.950270497248, 4976.884823949807, 5199.11615025439, 5227.294315267391, 5236.92144617831, 5263.26314315996, 5271.973640131775, 4780.808767649255, 4838.879028024327, 4925.975370123198, 4930.334404855299, 4950.985048065138, 2737.7262273772462, 2760.8619569021466, 2794.351332713709, 2805.5791631255474, 2821.463921854841, 5347.919781203285, 5351.81268655603, 5353.170258609922, 5379.67721936685, 5394.595405344537, 4921.753912304371, 5193.844184674465, 5207.973960130175, 5214.3053507610175, 5280.788768449219, 5271.7578689106695, 5288.65623734456, 5303.7348132593215, 5338.706371149547, 5370.812021579148, 5225.216217567396, 5230.529252367305, 5256.868578285574, 5262.289590905179, 5269.631125821309, 5190.455002224712, 5490.121580547093, 5866.882662346644, 5900.1149827526215, 5906.911396329145, 6149.754009839557, 6191.690415479298, 6200.968995154995, 6270.529710271657, 6273.435390814849, 4033.677305815469, 4225.556316586837, 4230.725002874803, 4276.5082015568605, 4291.291936830513, 5819.272590926134, 5925.970370148121, 5938.406159384027, 5951.732172052181, 5987.461128498456, 5763.423657634203, 5773.826785196451, 5825.242718446744, 5827.912581311199, 5856.648601083949, 5755.424457554379, 5766.308043034863, 5767.163761254678, 5770.451807078321, 5778.711064446845, 5680.744366503434, 5737.655740655574, 5779.988502012047, 5813.418658134153, 5842.737076831468, 5820.388859169726, 5824.825255242349, 5834.38738932406, 5860.941390586039, 5862.882742345215, 5608.4111168326735, 5669.858253543694, 5705.686187259741, 5732.656040637575, 5738.942610573841], "value": 4280.648931834629, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.4964624055642, 788.2747871957802, 788.3732432715993, 820.1839170025826, 864.7189663359405, 15534.533963981085, 16495.092769897652, 16552.75170872438, 16596.087215203173, 16642.25109870056, 13973.161610303363, 14054.789178162337, 14062.0, 14094.647633809134, 14183.432662693505, 769.7613739740684, 790.5928446849877, 813.780279324582, 814.4624547798454, 821.1337039423406, 807.112176605732, 811.995940020299, 814.1085511365046, 814.2630919018297, 814.5479259011246, 841.6380956188837, 847.326375531454, 847.4915050969431, 849.8512760266929, 850.4259624753298, 836.0469065265602, 842.5492361586553, 843.7763992541982, 845.1632883445407, 845.5222799118478, 613.5980932489226, 613.6011592464889, 614.7940439952577, 615.1818081951039, 616.7594638091148, 13858.16850988944, 13865.722685546334, 13898.51355202563, 13902.58292251224, 13930.791038134435, 14151.29243537819, 14153.575392738234, 14177.78733319001, 14406.495772648012, 14613.830893528493, 12081.818772718416, 12195.0, 12255.93872030643, 12399.62801115959, 12580.056495762854, 3579.391503444395, 3604.6755791978585, 3658.707303415747, 3687.322268367913, 3707.3326801175776, 84329.0, 84706.15293847045, 84745.57627211887, 85389.0, 88675.55662221648, 10825.945870270756, 11022.559097636005, 11048.226624136234, 11249.0, 11356.148288878367, 20400.387988360373, 20646.0, 20815.583688326147, 20816.47958801012, 20897.268595599082, 8257.710980115668, 8291.170882911661, 8302.418830681914, 8440.451370660887, 8525.232729054414, 4577.473590537064, 4608.078384323148, 4621.2837010263465, 4665.323528088408, 4685.672002959828, 3488.808115553669, 3544.6455354464347, 3582.2119133790525, 3607.0, 3608.585012723518, 628.0704557255287, 636.7516668499289, 639.2488825629866, 643.9034144878212, 655.9311272316338, 575.1709563587831, 629.087822657149, 650.1807722269974, 664.5049438168595, 675.6621689155422, 8899.955500222457, 9268.512511699551, 9317.534123293808, 9594.904050959542, 9984.650537231162, 581.7294957844623, 601.0623427453187, 686.4234043403565, 687.7249100359896, 777.4363586399814, 4404.405405270311, 4573.47405048417, 4621.445426548836, 4659.138059459011, 4808.35087263222, 64546.35453645497, 65993.34006659967, 66310.66844665745, 74612.0, 110421.44789276003, 86396.56801715952, 89638.55180724054, 90015.54992224996, 91310.54344728366, 92887.53556232176, 53154.7342263294, 55000.0, 71439.64280178565, 81601.18398816054, 84799.57600211959, 8747.737567872973, 8859.955700221457, 8871.467711937305, 9168.129027742354, 9200.907990920274, 48303.0, 48493.75753121212, 48676.75661621811, 49619.75190124026, 49939.75030124826, 66844.33155668381, 73967.26032739604, 74346.62826685832, 74651.0, 80245.5987720081, 11660.650180494598, 11764.70588235301, 11890.762184756084, 12161.635150945485, 12253.571125010581, 13073.280969546386, 13141.277229752073, 13201.60395188146, 13263.602091937257, 13817.378217980015, 11892.881071189177, 12412.379381031093, 12500.187487813264, 12710.745785084431, 13450.12574182675, 12078.698032549257, 12155.635330940086, 12481.313527755698, 12498.687532811753, 12731.0, 11015.559377624806, 11211.271267367594, 11505.42472876336, 11632.767344653228, 11886.524539018343, 10350.430726310125, 10375.0, 10389.9480502597, 10590.735231619272, 10866.185036122164, 10570.735731606464, 10789.514471848943, 10873.401962892116, 10873.454538185424, 10876.456177191267], "value": 7208.547353666935, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1518.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 111.0, 113.0, 110.0, 113.0, 111.0, 112.0, 112.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 125.0, 124.0, 176.0, 130.0, 127.0, 127.0, 127.0, 160.0, 129.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 169.0, 166.0, 163.0, 163.0, 164.0, 166.0, 163.0, 161.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 118.0, 80.0, 76.0, 76.0, 77.0, 112.0, 77.0], "value": 84.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 109.0, 84.0, 84.0, 83.0, 106.0, 87.0, 83.0, 107.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 119.0, 119.0, 118.0, 118.0, 119.0, 117.0, 117.0, 117.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 155.0, 147.0, 147.0, 147.0, 148.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 85.0, 86.0, 85.0, 87.0, 85.0, 85.0, 86.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 56.0, 55.0, 56.0, 57.0, 59.0, 56.0, 56.0, 57.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 61.0, 60.0, 61.0, 60.0, 61.0, 59.0, 60.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 81.0, 82.0, 81.0, 82.0, 81.0, 80.0, 82.0, 81.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 144.0, 135.0, 137.0, 133.0, 136.0, 134.0, 130.0, 231.0, 137.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 168.0, 169.0, 168.0, 167.0, 170.0, 169.0, 168.0, 166.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 67.0, 66.0, 69.0, 67.0, 65.0, 65.0, 73.0, 67.0], "value": 67.7, "unit": "score"}]}]} 23:47:22 INFO - Return code: 0 23:47:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:47:22 ERROR - # TBPL SUCCESS # 23:47:22 INFO - Running post-action listener: _resource_record_post_action 23:47:22 INFO - [mozharness: 2016-10-20 06:47:22.091582Z] Finished run-tests step (success) 23:47:22 INFO - Running post-run listener: _resource_record_post_run 23:47:22 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391057408; Read time: 20; Write time: 264776 23:47:22 INFO - TinderboxPrint: CPU usage
13.5% 23:47:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 23:47:22 INFO - TinderboxPrint: I/O write bytes / time
391,057,408 / 264,776 23:47:22 INFO - TinderboxPrint: CPU idle
8,260.9 (86.5%) 23:47:22 INFO - TinderboxPrint: CPU user
1,222.8 (12.8%) 23:47:22 INFO - TinderboxPrint: Swap in / out
0 / 0 23:47:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103546880; Read time: 0; Write time: 93356 23:47:22 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287047680; Read time: 0; Write time: 171416 23:47:22 INFO - Running post-run listener: _upload_blobber_files 23:47:22 INFO - Blob upload gear active. 23:47:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:47:22 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 23:47:22 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:47:22 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:47:23 INFO - (blobuploader) - INFO - Open directory for files ... 23:47:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:47:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:47:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:47:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:47:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:47:23 INFO - (blobuploader) - INFO - Done attempting. 23:47:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:47:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:47:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:47:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:47:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:47:24 INFO - (blobuploader) - INFO - Done attempting. 23:47:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:47:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:47:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:47:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:47:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:47:27 INFO - (blobuploader) - INFO - Done attempting. 23:47:27 INFO - (blobuploader) - INFO - Iteration through files over. 23:47:27 INFO - Return code: 0 23:47:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:47:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:47:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5abf41dd625364a50257044d032c75df64eaacbbd7e21083a92c94e7376c0d7a2ab162d475ddc2bc066efe01a9f23184bbf494d4fe1dfeccb6ffdbaac7782b65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8ff1979c8a250b633d16d9342eed1ed91593ad2f024d7d0505ca027218c11a63f60db561d0f5c5b39156a66ccf7cdb9ddbe3e6813f85e734a0f9c26f47e834ae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4952c577b15dcd7fa1ec2434bd85c404cc87c169423d715e1806513ad492a5f4d1f687312786e210fce9ad0dcd611e168ea64f11aedfa83cb71ffde526d87104"} 23:47:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:47:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:47:27 INFO - Contents: 23:47:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5abf41dd625364a50257044d032c75df64eaacbbd7e21083a92c94e7376c0d7a2ab162d475ddc2bc066efe01a9f23184bbf494d4fe1dfeccb6ffdbaac7782b65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8ff1979c8a250b633d16d9342eed1ed91593ad2f024d7d0505ca027218c11a63f60db561d0f5c5b39156a66ccf7cdb9ddbe3e6813f85e734a0f9c26f47e834ae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4952c577b15dcd7fa1ec2434bd85c404cc87c169423d715e1806513ad492a5f4d1f687312786e210fce9ad0dcd611e168ea64f11aedfa83cb71ffde526d87104"} 23:47:27 INFO - Running post-run listener: copy_logs_to_upload_dir 23:47:27 INFO - Copying logs to upload dir... 23:47:27 INFO - mkdir: /builds/slave/test/build/upload/logs 23:47:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.151175 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-19 23:47:27.804891) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 23:47:27.808147) ========= 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=db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5abf41dd625364a50257044d032c75df64eaacbbd7e21083a92c94e7376c0d7a2ab162d475ddc2bc066efe01a9f23184bbf494d4fe1dfeccb6ffdbaac7782b65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8ff1979c8a250b633d16d9342eed1ed91593ad2f024d7d0505ca027218c11a63f60db561d0f5c5b39156a66ccf7cdb9ddbe3e6813f85e734a0f9c26f47e834ae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4952c577b15dcd7fa1ec2434bd85c404cc87c169423d715e1806513ad492a5f4d1f687312786e210fce9ad0dcd611e168ea64f11aedfa83cb71ffde526d87104"} build_url:https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/cexO3zz0TJe-unQfEoCfTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5abf41dd625364a50257044d032c75df64eaacbbd7e21083a92c94e7376c0d7a2ab162d475ddc2bc066efe01a9f23184bbf494d4fe1dfeccb6ffdbaac7782b65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8ff1979c8a250b633d16d9342eed1ed91593ad2f024d7d0505ca027218c11a63f60db561d0f5c5b39156a66ccf7cdb9ddbe3e6813f85e734a0f9c26f47e834ae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4952c577b15dcd7fa1ec2434bd85c404cc87c169423d715e1806513ad492a5f4d1f687312786e210fce9ad0dcd611e168ea64f11aedfa83cb71ffde526d87104"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 23:47:27.834262) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 23:47:27.834596) ========= 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=db7e7c15f3ca076d53731445000001ba-1476941129.620679-55679064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 23:47:27.919771) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 23:47:27.920101) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 23:47:27.920407) ========= ========= Total master_lag: 0.28 =========