builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1476790423.92 results: success (0) buildid: 20161018014608 builduid: 0cc569251c044911aa5cbeaa0b8c2322 revision: dc89484d4b45 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 04:33:43.921528) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 04:33:43.921991) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 04:33:43.922262) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 04:33:43.937182) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:33:43.937555) ========= 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=5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-18 04:33: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 62.4M=0s 2016-10-18 04:33:44 (62.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123255 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:33:44.074615) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:33:44.075016) ========= 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=5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020118 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:33:44.124589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 04:33:44.125006) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dc89484d4b45 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev dc89484d4b45 --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=5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-18 04:33:44,197 Setting DEBUG logging. 2016-10-18 04:33:44,197 attempt 1/10 2016-10-18 04:33:44,198 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dc89484d4b45?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-18 04:33:45,022 unpacking tar archive at: mozilla-central-dc89484d4b45/testing/mozharness/ program finished with exit code 0 elapsedTime=1.148327 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 04:33:45.286564) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 04:33:45.289982) ========= script_repo_revision: dc89484d4b45 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 04:33:45.290451) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 04:33:45.290737) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 04:33:45.300742) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-18 04:33:45.301117) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:33:45 INFO - MultiFileLogger online at 20161018 04:33:45 in /builds/slave/test 04:33:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:33:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:33:45 INFO - {'append_to_log': False, 04:33:45 INFO - 'base_work_dir': '/builds/slave/test', 04:33:45 INFO - 'blob_upload_branch': 'Firefox', 04:33:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:33:45 INFO - 'branch': 'Firefox', 04:33:45 INFO - 'buildbot_json_path': 'buildprops.json', 04:33:45 INFO - 'config_files': ('talos/linux_config.py',), 04:33:45 INFO - 'default_actions': ('clobber', 04:33:45 INFO - 'read-buildbot-config', 04:33:45 INFO - 'download-and-extract', 04:33:45 INFO - 'populate-webroot', 04:33:45 INFO - 'create-virtualenv', 04:33:45 INFO - 'install', 04:33:45 INFO - 'run-tests'), 04:33:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:33:45 INFO - 'download_minidump_stackwalk': True, 04:33:45 INFO - 'download_symbols': 'ondemand', 04:33:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:33:45 INFO - 'tooltool.py': '/tools/tooltool.py', 04:33:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:33:45 INFO - '/tools/misc-python/virtualenv.py')}, 04:33:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:33:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:33:45 INFO - 'installer_path': 'installer.exe', 04:33:45 INFO - 'log_level': 'info', 04:33:45 INFO - 'log_name': 'talos', 04:33:45 INFO - 'log_to_console': True, 04:33:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:33:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:33:45 INFO - 'opt_config_files': (), 04:33:45 INFO - 'pip_index': False, 04:33:45 INFO - 'sps_profile': False, 04:33:45 INFO - 'sps_profile_interval': 0, 04:33:45 INFO - 'suite': 'dromaeojs', 04:33:45 INFO - 'system_bits': '32', 04:33:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:33:45 INFO - 'title': 'talos-linux64-ix-011', 04:33:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:33:45 INFO - 'use_talos_json': True, 04:33:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:33:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:33:45 INFO - 'work_dir': 'build'} 04:33:45 INFO - [mozharness: 2016-10-18 11:33:45.472664Z] Running clobber step. 04:33:45 INFO - Running pre-action listener: _resource_record_pre_action 04:33:45 INFO - Running main action method: clobber 04:33:45 INFO - rmtree: /builds/slave/test/build 04:33:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:33:46 INFO - Running post-action listener: _resource_record_post_action 04:33:46 INFO - [mozharness: 2016-10-18 11:33:46.426897Z] Finished clobber step (success) 04:33:46 INFO - [mozharness: 2016-10-18 11:33:46.426995Z] Running read-buildbot-config step. 04:33:46 INFO - Running pre-action listener: _resource_record_pre_action 04:33:46 INFO - Running main action method: read_buildbot_config 04:33:46 INFO - Using buildbot properties: 04:33:46 INFO - { 04:33:46 INFO - "project": "", 04:33:46 INFO - "product": "firefox", 04:33:46 INFO - "script_repo_revision": "production", 04:33:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:33:46 INFO - "repository": "", 04:33:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 04:33:46 INFO - "buildid": "20161018014608", 04:33:46 INFO - "pgo_build": "True", 04:33:46 INFO - "basedir": "/builds/slave/test", 04:33:46 INFO - "buildnumber": 14, 04:33:46 INFO - "slavename": "talos-linux64-ix-011", 04:33:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:33:46 INFO - "platform": "ubuntu64_hw", 04:33:46 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 04:33:46 INFO - "branch": "mozilla-central", 04:33:46 INFO - "repo_path": "mozilla-central", 04:33:46 INFO - "revision": "dc89484d4b45", 04:33:46 INFO - "stage_platform": "linux64-pgo", 04:33:46 INFO - "builduid": "0cc569251c044911aa5cbeaa0b8c2322", 04:33:46 INFO - "slavebuilddir": "test" 04:33:46 INFO - } 04:33:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:33:46 INFO - Running post-action listener: _resource_record_post_action 04:33:46 INFO - [mozharness: 2016-10-18 11:33:46.429398Z] Finished read-buildbot-config step (success) 04:33:46 INFO - [mozharness: 2016-10-18 11:33:46.429496Z] Running download-and-extract step. 04:33:46 INFO - Running pre-action listener: _resource_record_pre_action 04:33:46 INFO - Running main action method: download_and_extract 04:33:46 INFO - mkdir: /builds/slave/test/build/tests 04:33: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')]} 04:33:46 INFO - trying https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:33:46 INFO - Downloading https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/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 04:33:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/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 04:33:46 INFO - Downloaded 1361 bytes. 04:33:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:33:46 INFO - Using the following test package requirements: 04:33:46 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:33:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:33:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:33:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:47 INFO - u'jsshell-linux-x86_64.zip'], 04:33:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:33:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:33:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:33:47 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:33:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:33:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:33:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:33:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:33:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:33:47 INFO - Fetch https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:33:47 INFO - Http code: 200 04:33:47 INFO - via: 1.1 95da1452a75435200220a7075ca3893f.cloudfront.net (CloudFront) 04:33:47 INFO - x-amz-cf-id: 0wxGReAKY1zYMkEeevBELr1NqYOzbpVQGHCt92KyXjXYFTeXDHAHXw== 04:33:47 INFO - x-amz-version-id: hDisJmmPgU6YZoRw_F6iXDzTk1.WJhrY 04:33:47 INFO - Expected file size: 22089785 04:33:47 INFO - Obtained file size: 22089785 04:33: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 04:33:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:33:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:33:52 INFO - Fetch https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:33:52 INFO - Http code: 200 04:33:52 INFO - via: 1.1 5574699f9d8b8aad21acf2edbb25dc62.cloudfront.net (CloudFront) 04:33:52 INFO - x-amz-cf-id: 7Zv6skuWkG0hWc9KXQYxY3OMiXYNDa3NURq3tp-SrJzx2xBfRtUg3A== 04:33:52 INFO - x-amz-version-id: hDisJmmPgU6YZoRw_F6iXDzTk1.WJhrY 04:33:52 INFO - Expected file size: 22089785 04:33:52 INFO - Obtained file size: 22089785 04:33:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:33:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:33:57 INFO - Fetch https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:33:57 INFO - Http code: 200 04:33:57 INFO - via: 1.1 2a47832c458ab2a6b20c8363f5aa35ea.cloudfront.net (CloudFront) 04:33:57 INFO - x-amz-cf-id: l8KgV4sYYtnUlADDKpi8rrTJeeaxnw9WJt_f082sLMTUN5xmYo_20w== 04:33:57 INFO - x-amz-version-id: 6.BOolhyceGcVmxAEi2g9HpHxJH8zxpN 04:33:58 INFO - Expected file size: 14409028 04:33:58 INFO - Obtained file size: 14409028 04:33:58 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')]} 04:33:58 INFO - trying https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:33:58 INFO - Downloading https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/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 04:33:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/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 04:34:00 INFO - Downloaded 59459101 bytes. 04:34:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:34:00 INFO - mkdir: /builds/slave/test/properties 04:34:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:34:00 INFO - Writing to file /builds/slave/test/properties/build_url 04:34:00 INFO - Contents: 04:34:00 INFO - build_url:https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:34:00 INFO - Running post-action listener: _resource_record_post_action 04:34:00 INFO - Running post-action listener: set_extra_try_arguments 04:34:00 INFO - [mozharness: 2016-10-18 11:34:00.876913Z] Finished download-and-extract step (success) 04:34:00 INFO - [mozharness: 2016-10-18 11:34:00.877139Z] Running populate-webroot step. 04:34:00 INFO - Running pre-action listener: _resource_record_pre_action 04:34:00 INFO - Running main action method: populate_webroot 04:34:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:34:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:34:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:34:00 INFO - '--tppagecycles', 04:34:00 INFO - '7'], 04:34:00 INFO - 'tests': ['tsvgm']}}, 04:34:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:34:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:34:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:34:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:34:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:34:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:34:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:00 INFO - 'talos_options': ['--disable-e10s'], 04:34:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:00 INFO - 'talos_options': ['--disable-e10s'], 04:34:00 INFO - 'tests': ['damp', 'tps']}, 04:34:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:00 INFO - 'tests': ['damp', 'tps']}, 04:34:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:34:00 INFO - 'tests': ['dromaeo_dom']}, 04:34:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:34:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:34:00 INFO - 'tests': ['basic_compositor_video']}, 04:34:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:34:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:34:00 INFO - 'tests': ['a11yr', 04:34:00 INFO - 'ts_paint', 04:34:00 INFO - 'tpaint', 04:34:00 INFO - 'sessionrestore', 04:34:00 INFO - 'sessionrestore_no_auto_restore', 04:34:00 INFO - 'tabpaint']}, 04:34:00 INFO - 'other-e10s': {'tests': ['a11yr', 04:34:00 INFO - 'ts_paint', 04:34:00 INFO - 'tpaint', 04:34:00 INFO - 'sessionrestore', 04:34:00 INFO - 'sessionrestore_no_auto_restore', 04:34:00 INFO - 'tabpaint']}, 04:34:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:34:00 INFO - 'ts_paint', 04:34:00 INFO - 'tpaint', 04:34:00 INFO - 'sessionrestore', 04:34:00 INFO - 'sessionrestore_no_auto_restore', 04:34:00 INFO - 'tabpaint']}, 04:34:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:34:00 INFO - 'ts_paint', 04:34:00 INFO - 'tpaint', 04:34:00 INFO - 'sessionrestore', 04:34:00 INFO - 'sessionrestore_no_auto_restore', 04:34:00 INFO - 'tabpaint']}, 04:34:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:34:00 INFO - 'tests': ['a11yr', 04:34:00 INFO - 'ts_paint', 04:34:00 INFO - 'tpaint', 04:34:00 INFO - 'sessionrestore', 04:34:00 INFO - 'sessionrestore_no_auto_restore', 04:34:00 INFO - 'tabpaint']}, 04:34:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:34:00 INFO - 'tests': ['a11yr', 04:34:00 INFO - 'ts_paint', 04:34:00 INFO - 'tpaint', 04:34:00 INFO - 'sessionrestore', 04:34:00 INFO - 'sessionrestore_no_auto_restore', 04:34:00 INFO - 'tabpaint']}, 04:34:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:34:00 INFO - 'tests': ['tsvgx', 04:34:00 INFO - 'tsvgr_opacity', 04:34:00 INFO - 'tart', 04:34:00 INFO - 'tscrollx', 04:34:00 INFO - 'cart']}, 04:34:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:34:00 INFO - 'tsvgr_opacity', 04:34:00 INFO - 'tart', 04:34:00 INFO - 'tscrollx', 04:34:00 INFO - 'cart']}, 04:34:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:00 INFO - 'talos_options': ['--disable-e10s'], 04:34:00 INFO - 'tests': ['tp5o']}, 04:34:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:00 INFO - 'tests': ['tp5o']}, 04:34:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:00 INFO - 'talos_options': ['--disable-e10s', 04:34:00 INFO - '--xperf_path', 04:34:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:00 INFO - 'tests': ['tp5n']}, 04:34:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:00 INFO - 'talos_options': ['--xperf_path', 04:34:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:00 INFO - 'tests': ['tp5n']}}, 04:34:00 INFO - 'talos.zip': {'path': '', 04:34:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:34:00 INFO - Running post-action listener: _resource_record_post_action 04:34:00 INFO - [mozharness: 2016-10-18 11:34:00.895846Z] Finished populate-webroot step (success) 04:34:00 INFO - [mozharness: 2016-10-18 11:34:00.895934Z] Running create-virtualenv step. 04:34:00 INFO - Running pre-action listener: _resource_record_pre_action 04:34:00 INFO - Running main action method: create_virtualenv 04:34:00 INFO - Creating virtualenv /builds/slave/test/build/venv 04:34:00 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 04:34:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:34:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:34:00 INFO - Using real prefix '/usr' 04:34:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:34:01 INFO - Installing distribute.............................................................................................................................................................................................done. 04:34:03 INFO - Installing pip.................done. 04:34:03 INFO - Return code: 0 04:34:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:34:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:34:03 INFO - Reading from file tmpfile_stdout 04:34:03 INFO - Output received: 04:34:03 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) 04:34:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:34:03 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')]} 04:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:03 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')]} 04:34:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:03 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 0x7fb5184b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f17b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1580790>, '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 0x1581690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1581b20>, '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': '5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686', '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 04:34:03 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 04:34:03 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 04:34:03 INFO - Using env: {'DISPLAY': ':0', 04:34:03 INFO - 'HOME': '/home/cltbld', 04:34:03 INFO - 'LANG': 'en_US.UTF-8', 04:34:03 INFO - 'LANGUAGE': 'en_US:en', 04:34:03 INFO - 'LOGNAME': 'cltbld', 04:34:03 INFO - 'MAIL': '/var/mail/cltbld', 04:34:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:03 INFO - 'MOZ_NO_REMOTE': '1', 04:34:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:03 INFO - 'NO_EM_RESTART': '1', 04:34:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:03 INFO - 'PWD': '/builds/slave/test', 04:34:03 INFO - 'SHELL': '/bin/bash', 04:34:03 INFO - 'SHLVL': '1', 04:34:03 INFO - 'TERM': 'linux', 04:34:03 INFO - 'TMOUT': '86400', 04:34:03 INFO - 'USER': 'cltbld', 04:34:03 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686', 04:34:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:03 INFO - '_': '/tools/buildbot/bin/python'} 04:34:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:03 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 04:34:03 INFO - Cleaning up... 04:34:03 INFO - Return code: 0 04:34:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:34:03 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')]} 04:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:03 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')]} 04:34:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:03 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 0x7fb5184b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f17b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1580790>, '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 0x1581690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1581b20>, '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': '5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686', '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 04:34:03 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 04:34:03 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 04:34:03 INFO - Using env: {'DISPLAY': ':0', 04:34:03 INFO - 'HOME': '/home/cltbld', 04:34:03 INFO - 'LANG': 'en_US.UTF-8', 04:34:03 INFO - 'LANGUAGE': 'en_US:en', 04:34:03 INFO - 'LOGNAME': 'cltbld', 04:34:03 INFO - 'MAIL': '/var/mail/cltbld', 04:34:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:03 INFO - 'MOZ_NO_REMOTE': '1', 04:34:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:03 INFO - 'NO_EM_RESTART': '1', 04:34:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:03 INFO - 'PWD': '/builds/slave/test', 04:34:03 INFO - 'SHELL': '/bin/bash', 04:34:03 INFO - 'SHLVL': '1', 04:34:03 INFO - 'TERM': 'linux', 04:34:03 INFO - 'TMOUT': '86400', 04:34:03 INFO - 'USER': 'cltbld', 04:34:03 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686', 04:34:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:03 INFO - '_': '/tools/buildbot/bin/python'} 04:34:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:04 INFO - Downloading/unpacking psutil>=3.1.1 04:34:04 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 04:34:04 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 04:34:04 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 04:34:04 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 04:34:04 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 04:34:04 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 04:34:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:34:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:06 INFO - Installing collected packages: psutil 04:34:06 INFO - Running setup.py install for psutil 04:34:06 INFO - building 'psutil._psutil_linux' extension 04:34:06 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 04:34:06 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 04:34:06 INFO - building 'psutil._psutil_posix' extension 04:34:06 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 04:34:06 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 04:34:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:06 INFO - Successfully installed psutil 04:34:06 INFO - Cleaning up... 04:34:06 INFO - Return code: 0 04:34:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:34:06 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')]} 04:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:06 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')]} 04:34:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:06 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 0x7fb5184b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f17b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1580790>, '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 0x1581690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1581b20>, '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': '5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686', '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 04:34:06 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 04:34:06 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 04:34:06 INFO - Using env: {'DISPLAY': ':0', 04:34:06 INFO - 'HOME': '/home/cltbld', 04:34:06 INFO - 'LANG': 'en_US.UTF-8', 04:34:06 INFO - 'LANGUAGE': 'en_US:en', 04:34:06 INFO - 'LOGNAME': 'cltbld', 04:34:06 INFO - 'MAIL': '/var/mail/cltbld', 04:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:06 INFO - 'MOZ_NO_REMOTE': '1', 04:34:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:06 INFO - 'NO_EM_RESTART': '1', 04:34:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:06 INFO - 'PWD': '/builds/slave/test', 04:34:06 INFO - 'SHELL': '/bin/bash', 04:34:06 INFO - 'SHLVL': '1', 04:34:06 INFO - 'TERM': 'linux', 04:34:06 INFO - 'TMOUT': '86400', 04:34:06 INFO - 'USER': 'cltbld', 04:34:06 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686', 04:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:06 INFO - '_': '/tools/buildbot/bin/python'} 04:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:34:06 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 04:34:06 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 04:34:06 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 04:34:06 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 04:34:06 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 04:34:06 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 04:34:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:34:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:34:08 INFO - Installing collected packages: mozsystemmonitor 04:34:08 INFO - Running setup.py install for mozsystemmonitor 04:34:09 INFO - Successfully installed mozsystemmonitor 04:34:09 INFO - Cleaning up... 04:34:09 INFO - Return code: 0 04:34:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:34:09 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')]} 04:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:09 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')]} 04:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:09 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 0x7fb5184b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f17b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1580790>, '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 0x1581690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1581b20>, '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': '5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686', '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 04:34:09 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 04:34:09 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 04:34:09 INFO - Using env: {'DISPLAY': ':0', 04:34:09 INFO - 'HOME': '/home/cltbld', 04:34:09 INFO - 'LANG': 'en_US.UTF-8', 04:34:09 INFO - 'LANGUAGE': 'en_US:en', 04:34:09 INFO - 'LOGNAME': 'cltbld', 04:34:09 INFO - 'MAIL': '/var/mail/cltbld', 04:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:09 INFO - 'MOZ_NO_REMOTE': '1', 04:34:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:09 INFO - 'NO_EM_RESTART': '1', 04:34:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:09 INFO - 'PWD': '/builds/slave/test', 04:34:09 INFO - 'SHELL': '/bin/bash', 04:34:09 INFO - 'SHLVL': '1', 04:34:09 INFO - 'TERM': 'linux', 04:34:09 INFO - 'TMOUT': '86400', 04:34:09 INFO - 'USER': 'cltbld', 04:34:09 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686', 04:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:09 INFO - '_': '/tools/buildbot/bin/python'} 04:34:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:09 INFO - Downloading/unpacking jsonschema==2.5.1 04:34:09 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 04:34:09 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 04:34:09 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 04:34:09 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 04:34:09 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 04:34:09 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 04:34:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:34:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:34:11 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 04:34:11 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 04:34:11 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 04:34:11 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 04:34:11 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 04:34:11 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 04:34:11 INFO - Downloading functools32-3.2.3-2.tar.gz 04:34:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:34:11 INFO - warning: no files found matching '*.txt' 04:34:11 INFO - no previously-included directories found matching 'build' 04:34:11 INFO - no previously-included directories found matching 'dist' 04:34:11 INFO - no previously-included directories found matching '.git*' 04:34:11 INFO - Installing collected packages: jsonschema, functools32 04:34:11 INFO - Running setup.py install for functools32 04:34:11 INFO - warning: no files found matching '*.txt' 04:34:11 INFO - no previously-included directories found matching 'build' 04:34:11 INFO - no previously-included directories found matching 'dist' 04:34:11 INFO - no previously-included directories found matching '.git*' 04:34:11 INFO - Successfully installed jsonschema functools32 04:34:11 INFO - Cleaning up... 04:34:11 INFO - Return code: 0 04:34:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:34:11 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')]} 04:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:11 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')]} 04:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:11 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 0x7fb5184b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f17b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1580790>, '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 0x1581690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1581b20>, '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': '5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686', '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 04:34:11 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 04:34:11 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 04:34:11 INFO - Using env: {'DISPLAY': ':0', 04:34:11 INFO - 'HOME': '/home/cltbld', 04:34:11 INFO - 'LANG': 'en_US.UTF-8', 04:34:11 INFO - 'LANGUAGE': 'en_US:en', 04:34:11 INFO - 'LOGNAME': 'cltbld', 04:34:11 INFO - 'MAIL': '/var/mail/cltbld', 04:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:11 INFO - 'MOZ_NO_REMOTE': '1', 04:34:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:11 INFO - 'NO_EM_RESTART': '1', 04:34:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:11 INFO - 'PWD': '/builds/slave/test', 04:34:11 INFO - 'SHELL': '/bin/bash', 04:34:11 INFO - 'SHLVL': '1', 04:34:11 INFO - 'TERM': 'linux', 04:34:11 INFO - 'TMOUT': '86400', 04:34:11 INFO - 'USER': 'cltbld', 04:34:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686', 04:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:11 INFO - '_': '/tools/buildbot/bin/python'} 04:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:34:11 INFO - Cleaning up... 04:34:11 INFO - Return code: 0 04:34:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:34:11 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')]} 04:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:11 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')]} 04:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:11 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 0x7fb5184b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f17b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1580790>, '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 0x1581690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1581b20>, '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': '5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686', '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 04:34:11 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 04:34:11 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 04:34:11 INFO - Using env: {'DISPLAY': ':0', 04:34:11 INFO - 'HOME': '/home/cltbld', 04:34:11 INFO - 'LANG': 'en_US.UTF-8', 04:34:11 INFO - 'LANGUAGE': 'en_US:en', 04:34:11 INFO - 'LOGNAME': 'cltbld', 04:34:11 INFO - 'MAIL': '/var/mail/cltbld', 04:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:11 INFO - 'MOZ_NO_REMOTE': '1', 04:34:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:11 INFO - 'NO_EM_RESTART': '1', 04:34:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:11 INFO - 'PWD': '/builds/slave/test', 04:34:11 INFO - 'SHELL': '/bin/bash', 04:34:11 INFO - 'SHLVL': '1', 04:34:11 INFO - 'TERM': 'linux', 04:34:11 INFO - 'TMOUT': '86400', 04:34:11 INFO - 'USER': 'cltbld', 04:34:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686', 04:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:11 INFO - '_': '/tools/buildbot/bin/python'} 04:34:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:12 INFO - Downloading/unpacking blobuploader==1.2.4 04:34: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 04:34: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 04:34: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 04:34: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 04:34: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 04:34: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 04:34:14 INFO - Downloading blobuploader-1.2.4.tar.gz 04:34:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:34:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:34:14 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 04:34:14 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 04:34:14 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 04:34:14 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 04:34:14 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 04:34:14 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 04:34:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:34:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:34:14 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 04:34:14 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 04:34:14 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 04:34:14 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 04:34:14 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 04:34:14 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 04:34:14 INFO - Downloading docopt-0.6.1.tar.gz 04:34:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:34:14 INFO - Installing collected packages: blobuploader, requests, docopt 04:34:14 INFO - Running setup.py install for blobuploader 04:34:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:34:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:34:14 INFO - Running setup.py install for requests 04:34:15 INFO - Running setup.py install for docopt 04:34:15 INFO - Successfully installed blobuploader requests docopt 04:34:15 INFO - Cleaning up... 04:34:15 INFO - Return code: 0 04:34:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:15 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 0x7fb5184b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f17b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1580790>, '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 0x1581690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1581b20>, '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': '5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686', '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 04:34:15 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 04:34:15 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 04:34:15 INFO - Using env: {'DISPLAY': ':0', 04:34:15 INFO - 'HOME': '/home/cltbld', 04:34:15 INFO - 'LANG': 'en_US.UTF-8', 04:34:15 INFO - 'LANGUAGE': 'en_US:en', 04:34:15 INFO - 'LOGNAME': 'cltbld', 04:34:15 INFO - 'MAIL': '/var/mail/cltbld', 04:34:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:15 INFO - 'MOZ_NO_REMOTE': '1', 04:34:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:15 INFO - 'NO_EM_RESTART': '1', 04:34:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:15 INFO - 'PWD': '/builds/slave/test', 04:34:15 INFO - 'SHELL': '/bin/bash', 04:34:15 INFO - 'SHLVL': '1', 04:34:15 INFO - 'TERM': 'linux', 04:34:15 INFO - 'TMOUT': '86400', 04:34:15 INFO - 'USER': 'cltbld', 04:34:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686', 04:34:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:15 INFO - '_': '/tools/buildbot/bin/python'} 04:34:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:15 INFO - Running setup.py (path:/tmp/pip-mr_TvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:15 INFO - Running setup.py (path:/tmp/pip-EHqBTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:15 INFO - Running setup.py (path:/tmp/pip-QAYkoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:15 INFO - Running setup.py (path:/tmp/pip-gDGzBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:15 INFO - Running setup.py (path:/tmp/pip-tFwIFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:16 INFO - Running setup.py (path:/tmp/pip-u1EGmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:34:16 INFO - Running setup.py (path:/tmp/pip-Xd9KGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:34:16 INFO - Running setup.py (path:/tmp/pip-i7RonR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:34:16 INFO - Running setup.py (path:/tmp/pip-JSOpeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:34:16 INFO - Running setup.py (path:/tmp/pip-XrCM3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:34:16 INFO - Running setup.py (path:/tmp/pip-nUKyRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:34:16 INFO - Running setup.py (path:/tmp/pip-qcVfT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:34:16 INFO - Running setup.py (path:/tmp/pip-yJCUH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:34:16 INFO - Running setup.py (path:/tmp/pip-tS_Bmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:16 INFO - Running setup.py (path:/tmp/pip-Z5IvUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:34:16 INFO - Running setup.py (path:/tmp/pip-SPCoAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:34:16 INFO - Running setup.py (path:/tmp/pip-EMe1gB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:34:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:34:16 INFO - Running setup.py install for manifestparser 04:34:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:34:17 INFO - Running setup.py install for mozcrash 04:34:17 INFO - Running setup.py install for mozdebug 04:34:17 INFO - Running setup.py install for mozdevice 04:34:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:34:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:34:17 INFO - Running setup.py install for mozfile 04:34:17 INFO - Running setup.py install for mozhttpd 04:34:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:34:17 INFO - Running setup.py install for mozinfo 04:34:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:34:17 INFO - Running setup.py install for mozInstall 04:34:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:34:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:34:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:34:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:34:17 INFO - Running setup.py install for mozleak 04:34:17 INFO - Running setup.py install for mozlog 04:34:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:34:17 INFO - Running setup.py install for moznetwork 04:34:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:34:18 INFO - Running setup.py install for mozprocess 04:34:18 INFO - Running setup.py install for mozprofile 04:34:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:34:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:34:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:34:18 INFO - Running setup.py install for mozrunner 04:34:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:34:18 INFO - Running setup.py install for mozscreenshot 04:34:18 INFO - Running setup.py install for moztest 04:34:18 INFO - Running setup.py install for mozversion 04:34:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:34:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:34:18 INFO - Cleaning up... 04:34:18 INFO - Return code: 0 04:34:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:18 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 0x7fb5184b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f17b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1580790>, '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 0x1581690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1581b20>, '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': '5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686', '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 04:34:18 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 04:34:18 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 04:34:18 INFO - Using env: {'DISPLAY': ':0', 04:34:18 INFO - 'HOME': '/home/cltbld', 04:34:18 INFO - 'LANG': 'en_US.UTF-8', 04:34:18 INFO - 'LANGUAGE': 'en_US:en', 04:34:18 INFO - 'LOGNAME': 'cltbld', 04:34:18 INFO - 'MAIL': '/var/mail/cltbld', 04:34:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:18 INFO - 'MOZ_NO_REMOTE': '1', 04:34:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:18 INFO - 'NO_EM_RESTART': '1', 04:34:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:18 INFO - 'PWD': '/builds/slave/test', 04:34:18 INFO - 'SHELL': '/bin/bash', 04:34:18 INFO - 'SHLVL': '1', 04:34:18 INFO - 'TERM': 'linux', 04:34:18 INFO - 'TMOUT': '86400', 04:34:18 INFO - 'USER': 'cltbld', 04:34:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686', 04:34:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:18 INFO - '_': '/tools/buildbot/bin/python'} 04:34:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:18 INFO - Running setup.py (path:/tmp/pip-q3eZUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:18 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)) 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:19 INFO - Running setup.py (path:/tmp/pip-aXMRvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:19 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)) 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:19 INFO - Running setup.py (path:/tmp/pip-nsYYFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:19 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)) 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:19 INFO - Running setup.py (path:/tmp/pip-qgSjbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:19 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)) 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:19 INFO - Running setup.py (path:/tmp/pip-r1BP8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:19 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)) 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:19 INFO - Running setup.py (path:/tmp/pip-DdurVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:34:19 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)) 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:34:19 INFO - Running setup.py (path:/tmp/pip-MK6sX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:34:19 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)) 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:34:19 INFO - Running setup.py (path:/tmp/pip-Ulozfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:34:19 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)) 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:34:19 INFO - Running setup.py (path:/tmp/pip-7s0lc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:34:19 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)) 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:34:19 INFO - Running setup.py (path:/tmp/pip-9GANlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:34:19 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)) 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:34:19 INFO - Running setup.py (path:/tmp/pip-KmtFIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:34:19 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)) 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:34:19 INFO - Running setup.py (path:/tmp/pip-AJzp2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:34:19 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)) 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:34:19 INFO - Running setup.py (path:/tmp/pip-7zcHQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:34:19 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)) 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:34:19 INFO - Running setup.py (path:/tmp/pip-fTM0Nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:34:20 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)) 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:20 INFO - Running setup.py (path:/tmp/pip-hB3z80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:20 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)) 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:34:20 INFO - Running setup.py (path:/tmp/pip-j_1sdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:34:20 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)) 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:34:20 INFO - Running setup.py (path:/tmp/pip-2YH0kF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:34:20 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)) 04:34:20 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)) 04:34:20 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)) 04:34:20 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)) 04:34:20 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)) 04:34:20 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)) 04:34:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:22 INFO - Downloading blessings-1.6.tar.gz 04:34:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:34:22 INFO - Installing collected packages: blessings 04:34:22 INFO - Running setup.py install for blessings 04:34:22 INFO - Successfully installed blessings 04:34:22 INFO - Cleaning up... 04:34:22 INFO - Return code: 0 04:34:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:34:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:34:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:34:22 INFO - Reading from file tmpfile_stdout 04:34:22 INFO - Current package versions: 04:34:22 INFO - argparse == 1.2.1 04:34:22 INFO - blessings == 1.6 04:34:22 INFO - blobuploader == 1.2.4 04:34:22 INFO - docopt == 0.6.1 04:34:22 INFO - functools32 == 3.2.3-2 04:34:22 INFO - jsonschema == 2.5.1 04:34:22 INFO - manifestparser == 1.1 04:34:22 INFO - mozInstall == 1.12 04:34:22 INFO - mozcrash == 0.17 04:34:22 INFO - mozdebug == 0.1 04:34:22 INFO - mozdevice == 0.48 04:34:22 INFO - mozfile == 1.2 04:34:22 INFO - mozhttpd == 0.7 04:34:22 INFO - mozinfo == 0.9 04:34:22 INFO - mozleak == 0.1 04:34:22 INFO - mozlog == 3.4 04:34:22 INFO - moznetwork == 0.27 04:34:22 INFO - mozprocess == 0.23 04:34:22 INFO - mozprofile == 0.28 04:34:22 INFO - mozrunner == 6.12 04:34:22 INFO - mozscreenshot == 0.1 04:34:22 INFO - mozsystemmonitor == 0.3 04:34:22 INFO - moztest == 0.7 04:34:22 INFO - mozversion == 1.4 04:34:22 INFO - psutil == 3.1.1 04:34:22 INFO - requests == 1.2.3 04:34:22 INFO - wsgiref == 0.1.2 04:34:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:22 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 0x7fb5184b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f17b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1580790>, '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 0x1581690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1581b20>, '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': '5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686', '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 04:34:22 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 04:34:22 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 04:34:22 INFO - Using env: {'DISPLAY': ':0', 04:34:22 INFO - 'HOME': '/home/cltbld', 04:34:22 INFO - 'LANG': 'en_US.UTF-8', 04:34:22 INFO - 'LANGUAGE': 'en_US:en', 04:34:22 INFO - 'LOGNAME': 'cltbld', 04:34:22 INFO - 'MAIL': '/var/mail/cltbld', 04:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:22 INFO - 'MOZ_NO_REMOTE': '1', 04:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:22 INFO - 'NO_EM_RESTART': '1', 04:34:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:22 INFO - 'PWD': '/builds/slave/test', 04:34:22 INFO - 'SHELL': '/bin/bash', 04:34:22 INFO - 'SHLVL': '1', 04:34:22 INFO - 'TERM': 'linux', 04:34:22 INFO - 'TMOUT': '86400', 04:34:22 INFO - 'USER': 'cltbld', 04:34:22 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686', 04:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:22 INFO - '_': '/tools/buildbot/bin/python'} 04:34:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:22 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)) 04:34:22 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)) 04:34:22 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)) 04:34:22 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)) 04:34:22 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)) 04:34:22 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)) 04:34:22 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)) 04:34:22 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)) 04:34:22 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)) 04:34:22 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)) 04:34:22 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)) 04:34:22 INFO - Cleaning up... 04:34:22 INFO - Return code: 0 04:34:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5184b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f17b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1580790>, '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 0x1581690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1581b20>, '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': '5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686', '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 04:34:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:34:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:34:22 INFO - Using env: {'DISPLAY': ':0', 04:34:22 INFO - 'HOME': '/home/cltbld', 04:34:22 INFO - 'LANG': 'en_US.UTF-8', 04:34:22 INFO - 'LANGUAGE': 'en_US:en', 04:34:22 INFO - 'LOGNAME': 'cltbld', 04:34:22 INFO - 'MAIL': '/var/mail/cltbld', 04:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:22 INFO - 'MOZ_NO_REMOTE': '1', 04:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:22 INFO - 'NO_EM_RESTART': '1', 04:34:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:22 INFO - 'PWD': '/builds/slave/test', 04:34:22 INFO - 'SHELL': '/bin/bash', 04:34:22 INFO - 'SHLVL': '1', 04:34:22 INFO - 'TERM': 'linux', 04:34:22 INFO - 'TMOUT': '86400', 04:34:22 INFO - 'USER': 'cltbld', 04:34:22 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686', 04:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:22 INFO - '_': '/tools/buildbot/bin/python'} 04:34:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:34:23 INFO - Cleaning up... 04:34:23 INFO - Return code: 0 04:34:23 INFO - Running post-action listener: _resource_record_post_action 04:34:23 INFO - Running post-action listener: _start_resource_monitoring 04:34:23 INFO - Starting resource monitoring. 04:34:23 INFO - [mozharness: 2016-10-18 11:34:23.173260Z] Finished create-virtualenv step (success) 04:34:23 INFO - [mozharness: 2016-10-18 11:34:23.173840Z] Running install step. 04:34:23 INFO - Running pre-action listener: _resource_record_pre_action 04:34:23 INFO - Running main action method: install 04:34:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:34:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:34:23 INFO - Reading from file tmpfile_stdout 04:34:23 INFO - Detecting whether we're running mozinstall >=1.0... 04:34:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:34:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:34:23 INFO - Reading from file tmpfile_stdout 04:34:23 INFO - Output received: 04:34:23 INFO - Usage: mozinstall [options] installer 04:34:23 INFO - Options: 04:34:23 INFO - -h, --help show this help message and exit 04:34:23 INFO - -d DEST, --destination=DEST 04:34:23 INFO - Directory to install application into. [default: 04:34:23 INFO - "/builds/slave/test"] 04:34:23 INFO - --app=APP Application being installed. [default: firefox] 04:34:23 INFO - mkdir: /builds/slave/test/build/application 04:34:23 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'] 04:34:23 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 04:34:40 INFO - Reading from file tmpfile_stdout 04:34:40 INFO - Output received: 04:34:40 INFO - /builds/slave/test/build/application/firefox/firefox 04:34:40 INFO - Running post-action listener: _resource_record_post_action 04:34:40 INFO - [mozharness: 2016-10-18 11:34:40.971188Z] Finished install step (success) 04:34:40 INFO - [mozharness: 2016-10-18 11:34:40.971430Z] Running run-tests step. 04:34:40 INFO - Running pre-action listener: _resource_record_pre_action 04:34:40 INFO - Running main action method: run_tests 04:34:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:34:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:34:40 INFO - Python 2.7.3 04:34:40 INFO - Return code: 0 04:34:40 INFO - grabbing minidump binary from tooltool 04:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:40 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 0x1580790>, '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 0x1581690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1581b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:34:40 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 04:34:40 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 04:34:40 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 04:34:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:34:41 INFO - Return code: 0 04:34:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:34:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:34:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:34:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:34:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:34:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:34:41 INFO - Using env: {'DISPLAY': ':0', 04:34:41 INFO - 'HOME': '/home/cltbld', 04:34:41 INFO - 'LANG': 'en_US.UTF-8', 04:34:41 INFO - 'LANGUAGE': 'en_US:en', 04:34:41 INFO - 'LOGNAME': 'cltbld', 04:34:41 INFO - 'MAIL': '/var/mail/cltbld', 04:34:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:34:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:41 INFO - 'MOZ_NO_REMOTE': '1', 04:34:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:34:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:41 INFO - 'NO_EM_RESTART': '1', 04:34:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:41 INFO - 'PWD': '/builds/slave/test', 04:34:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:34:41 INFO - 'SHELL': '/bin/bash', 04:34:41 INFO - 'SHLVL': '1', 04:34:41 INFO - 'TERM': 'linux', 04:34:41 INFO - 'TMOUT': '86400', 04:34:41 INFO - 'USER': 'cltbld', 04:34:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686', 04:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:41 INFO - '_': '/tools/buildbot/bin/python'} 04:34:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:34:41 INFO - mozversion application_buildid: 20161018014608 04:34:41 INFO - mozversion application_changeset: dc89484d4b45abf442162e5ea2dd46f9de40197d 04:34:41 INFO - mozversion application_display_name: Nightly 04:34:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:34:41 INFO - mozversion application_name: Firefox 04:34:41 INFO - mozversion application_remotingname: firefox 04:34:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:34:41 INFO - mozversion application_vendor: Mozilla 04:34:41 INFO - mozversion application_version: 52.0a1 04:34:41 INFO - mozversion platform_buildid: 20161018014608 04:34:41 INFO - mozversion platform_changeset: dc89484d4b45abf442162e5ea2dd46f9de40197d 04:34:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:34:41 INFO - mozversion platform_version: 52.0a1 04:34:41 INFO - using testdate: 1476790481 04:34:41 INFO - actual date: 1476790481 04:34:41 INFO - starting webserver on 'localhost:51708' 04:34:41 INFO - SUITE-START | Running 2 tests 04:34:41 INFO - TEST-START | dromaeo_css 04:34:41 INFO - operating with platform_type : linux_ 04:34:41 INFO - Initialising browser for dromaeo_css test... 04:34:41 INFO - TEST-INFO | started process 16825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1gnKzz/profile http://localhost:51708/getInfo.html) 04:34:45 INFO - PROCESS | 16825 | __metrics Screen width/height:1600/1200 04:34:45 INFO - PROCESS | 16825 | colorDepth:24 04:34:45 INFO - PROCESS | 16825 | Browser inner width/height: 1024/697 04:34:45 INFO - PROCESS | 16825 | __metrics 04:34:46 INFO - PROCESS | 16825 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:34:46 INFO - PROCESS | 16825 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:34:47 INFO - PROCESS | 16825 | console.error: PushService: 04:34:47 INFO - PROCESS | 16825 | stateChangeProcessEnqueue: Error transitioning state 04:34:47 INFO - PROCESS | 16825 | UnknownError 04:34:48 INFO - TEST-INFO | 16825: exit 0 04:34:48 INFO - Browser initialized. 04:34:48 INFO - Running cycle 1/1 for dromaeo_css test... 04:34:48 INFO - TEST-INFO | started process 16910 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1gnKzz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:35:00 INFO - PROCESS | 16910 | RSS: Main: 172273664 04:35:00 INFO - PROCESS | 16910 | 04:35:52 INFO - PROCESS | 16910 | 1476790552019 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] 04:38:02 INFO - PROCESS | 16910 | Cycle 1(1): loaded http://localhost:51708/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51708/tests/dromaeo/cssquery-ext.html) 04:38:03 INFO - PROCESS | 16910 | RSS: Main: 296558592 04:38:03 INFO - PROCESS | 16910 | 04:41:06 INFO - PROCESS | 16910 | Cycle 1(1): loaded http://localhost:51708/tests/dromaeo/cssquery-ext.html (next: http://localhost:51708/tests/dromaeo/cssquery-jquery.html) 04:41:07 INFO - PROCESS | 16910 | RSS: Main: 273514496 04:41:07 INFO - PROCESS | 16910 | 04:44:09 INFO - PROCESS | 16910 | Cycle 1(1): loaded http://localhost:51708/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51708/tests/dromaeo/cssquery-mootools.html) 04:44:09 INFO - PROCESS | 16910 | RSS: Main: 217280512 04:44:09 INFO - PROCESS | 16910 | 04:47:11 INFO - PROCESS | 16910 | Cycle 1(1): loaded http://localhost:51708/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51708/tests/dromaeo/cssquery-prototype.html) 04:47:12 INFO - PROCESS | 16910 | RSS: Main: 213749760 04:47:12 INFO - PROCESS | 16910 | 04:50:15 INFO - PROCESS | 16910 | Cycle 1(1): loaded http://localhost:51708/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51708/tests/dromaeo/cssquery-yui.html) 04:50:15 INFO - PROCESS | 16910 | RSS: Main: 214614016 04:50:15 INFO - PROCESS | 16910 | 04:53:18 INFO - PROCESS | 16910 | Cycle 1(1): loaded http://localhost:51708/tests/dromaeo/cssquery-yui.html (next: http://localhost:51708/tests/dromaeo/cssquery-dojo.html) 04:53:19 INFO - PROCESS | 16910 | RSS: Main: 303931392 04:53:19 INFO - PROCESS | 16910 | 04:53:19 INFO - PROCESS | 16910 | __start_tp_report 04:53:19 INFO - PROCESS | 16910 | _x_x_mozilla_page_load 04:53:19 INFO - PROCESS | 16910 | _x_x_mozilla_page_load_details 04:53:19 INFO - PROCESS | 16910 | |i|pagename|runs| 04:53:19 INFO - PROCESS | 16910 | |0;dojo.html;3032.984835075825;3059.3116548776516;3088.891888783893;3101.860416281267;3102.9379412411754;5087.898242035167;5191;5209.192575150848;5295.443978382272;5353.73231338433;5213.087709650806;5218.608604354669;5327.200919862023;5336.493033161843;5367.087595108831;4728.881777955544;4747.287906813971;4795.520447955194;4806.134895718769;4826.61387089032;4810.759462026902;4856.344393506866;4873.293372460991;4877.244027175776;4937.1606826839525;4651.395318608593;4824.5899098576665;4830.758462076918;4832.05774873898;4932.531409516108;4687.20317546018;4712.104700106968;4747.240441529373;4748.5251474852585;4773.140834649762;4735.100330937111;4736.976315118437;4753.786079626425;4775.856724298276;4804.0872234275375;5193.792248310063;5232.1628539433505;5242.056429842627;5242.895142097137;5245.606579506514;5455.399906010336;5464.398916119224;5505.697186654733;5532.087205611109;5567.192757050246;5577.553795696334;5586.608937374385;5596.972015139939;5654.434556544354;5664.518515926151;5237.685738855681;5243.895122097575;5248.448912864171;5253.133233016548;5318.547923426552;5489.6980666062955;5547.472990065938;5561.749721262553;5670.858228544237;5682.602217844711;5463.863403414946;5502.614816962774;5521.089020311603;5528.115501519737;5596.1605759136455;5566.832995010156;5566.888662226733;5603.80386686464;5610.186522954149;5616.410276920946;5439.129739241703;5591.245181900473;5592.5246354059545;5596.076647353141;5599.776008959678;5474.507294343528;5478.534324582375;5505.917411238835;5525.171224316305;5612.382637909826;4334.718243314174;4369.890752731207;4377.233984052778;4381.671374646914;4385.51759306476;3857.1321452672923;3871.709621778378;3871.9032024199055;3916.412538119305;3922.882313530599;5209.817656382009;5283.656562323436;5290.497402746733;5294.97352513235;5299.867503312448;5513.531349835229;5569.916451253234;5635.802746903921;5636.351819540723;5719.399463056402;5313.601479888946;5333.839984800462;5359.705216213146;5360.276362691065;5361.892762144736;4823.734694591761;4840.2255639098275;4841.080194762983;4845.6608037437045;4902.8774280643265;5667.064934285879;5678.744456499468;5721.799737009184;5726.656400615976;5731.168980497721;5573.637713548606;5576.60963732551;5579.832605021856;5581.134924086773;5634.211210430625;5662.66024038559;5667.546596272371;5713;5713.514351280188;5735.283089613798;5386.461353864583;5397.730113494388;5418.810341638024;5471.179323101566;5519.751611177587;5577.163425486047;5627.352854421794;5631.4368563145;5682.090865461506;5702.287214098238;5493.670379777226;5499.202615620633;5504.174373843955;5506;5525.392206857162;5367.033933891937;5413.83758487246;5416.729163541729;5515.69663668486;5587.106063029895;5393.514583687487;5431.23962645222;5440.374356949002;5498.3127109111365;5509.228707980806;5517.5585953124455;5530.142827861688;5533.944660553343;5534.501894829485;5536.252605898313;5305.31030965972;5314.1497360422145;5347.839564813062;5351.304330437174;5386.569074474111 04:53:19 INFO - PROCESS | 16910 | |1;ext.html;571.1759768350889;592.9673867937263;597.6264834478451;627.7583130494758;657.3426573426574;31902.20244493886;35101.824490877574;35155.12112197196;35192.64807351926;35214.2957140857;35513.11217219571;45014.77492612533;45230.7738461308;45304;49363;8740.562971851414;8752.168543988311;8873.778155546132;8897.77755556113;8898.555072246394;8604.31165506758;8689.217970382664;8693.217610415062;8696.17386348299;8702.608382622766;8135.959320203391;8377;10566.788664226711;10762.192835537366;10787.67636970892;10739;10820.08029317509;10838.620648277272;10839.512221949992;10849.891501084967;10501.36991780488;10545;10555.683329500127;10577.84133238002;10579.153667706565;42301.15397692029;42512.149757005;42596;42726;42782.358264626055;3204.9198770030703;3318.4856347266214;3436.29555941034;3576.409892367756;3580.445031020196;31746.206344841565;32030.359392812246;32055.51916721251;32127.678723212703;32205.033848984567;3491.8777842775635;3617.5297211362354;3694.9445758313645;3765.8305376258136;3888.727789054767;284016;284434.9999999979;284654;285417;286949;57581.13628295579;57893;58038.419615804145;58062.4193758057;58146.127808082914;60124.69937650371;60505.411552978054;60842;60865.69567152136;60901.69549152226;15051.774223386657;15227.314770835339;15242;15316.923415383075;15318.540443786482;11107.500162492546;11200.607978720705;11202.439878006067;11204.047655949336;11204.383758893176;15090.24548772557;16703.248353824107;17402.651946961243;17459;17684;4957.603391728725;5789.2763404574425;5925.288965324103;6034.185384972972;6238.282597501346;864.8010957479814;942.2838642631513;975.5561219645044;1043.2957753516346;1116.0792346314324;31343.37313253722;32015.83992080025;32036.35927281488;32090.518642220384;32800;1016.7915577306634;1042.968710938673;1072.383379556758;1074.5594306334365;1132.9576789353814;15316.617084572752;16496.52389323941;16501.83498165003;16560.254788534305;16961.49115526536;441755;446797;448194;448244;449612;42994.570054299686;43660;54811.72594137004;56366;56534.43465565292;1284.5889315419163;1324.708564115893;1329.2157627000117;1350.7568637645318;1358.415881171086;30172.628972512943;32779.67220327766;33133.33733325368;33277.16807079843;33436.498452523716;45907;46273;46344.30483542817;46364.536354636024;46456.535434646576;385454;392917;395634;560090;560709;27338.45323093567;27551.448971020065;27663.308417288925;27681.446371072867;27725.72274277312;46913;47154.528454715015;47196;47258;48006;39821;40219.597804021585;41282.793586031876;41547.37678934758;43736.82095350536;39271.80364098161;39592.80203598963;40056;40596.59403405928;40960.59039409568;39561.80219098886;40612.79693601513;41210.79394603008;42578.36132458078;43149.56850431456;30845.38309233758;35105.154494873255;35565.466518002766;35943;36488.27023459463;26681.733182667926;26847.726427951926;26940.32649183786;26954.865225673748;27137.321566960196 04:53:19 INFO - PROCESS | 16910 | |2;jquery.html;361.95113659655937;373.89530931339226;375.8177284017251;378.5381834162321;395.5905637665017;14147.504837330696;18364.17361218745;18869.245230190776;19148.80851191488;20447;18580.814191858077;19180.42458726237;19222;19346.51633709158;19360.90319548404;5269.2886460327845;5520.475554822286;5573.972130139364;5578.776848926058;5601.943980560183;4057.5942405759333;4266;4304.612584867361;5469.288992430998;5498.615096943216;6123.8162855114415;6148.508119350464;6299.275583307933;6303.810885673437;6314.968425157867;6168.383161683818;6222.239926703429;6271.372862713738;6284.497240220771;6312.652804095773;5534.972325138388;5545.694986775726;5548.167774833767;5549.250851135126;5551.639143455663;22548.88725556362;23244.65133023006;23405.7659423407;23431.297061088193;23580.410489737722;2224.12147201856;2263.694401255826;2280.065173278948;2568.6018667106628;3001.823677833575;13437.731245375135;14130.36413361391;14389.64025899361;14774.261286935718;15066.623334416727;1813.9727904081449;1874.1378965675806;1936.4868309897888;1959.9706004409945;1998.590288990768;75643.62178189128;76735.61632191803;76789.61605191995;79266;79872.20127798706;10108.342957707726;10326.948365258126;10327.483625818679;10416.843747343795;10627.787444251071;14320.212388318743;14351.282435878164;14351.425942962165;14354.354054067591;14363.21002344881;7298.489105762652;7506.774796756106;7573.545587264782;7699.191584883619;7725.729599463992;7141.678624461912;7177.138743350727;7334.523255988343;7354.485186036926;7424.331810137113;6150.907736383958;6295.811125666146;6302.905456418157;6393.968030159819;6461.935380646228;1782.9554261143576;1841.5856432302626;1879.9342023029128;1893;1902.657521646117;912.1289168843738;994.8855881573712;1014.3052009373603;1030.299396410433;1054.752133248686;19142.8085719141;20167.899160504396;20247.39257822238;20395.592088158155;20516.281930132373;977.1742877268839;1023.5649848814373;1035.3994683083945;1038.2265212416798;1058.3702696895334;10498.265121441425;10935.664106848015;11064.502097405637;11084.168687348481;11308.434578271219;392369;409521;422793;427008;429042;75031.24968750242;76430.6178469104;77009.614951926;77180.61409693028;77790.22209777943;1025.994870025645;1042.374575254841;1054.8997845204694;1064.6060957445795;1067.1516144664854;16953.32186712567;17134.571635709206;17608.91195544014;17762.644747105245;18031.942812867;37557.624423756504;38669.41995870008;38832;39064.804675977575;39168.804155979036;50389.74805125951;50661.493385065674;51050.74474627603;51206.487935120174;52383.47616523786;7643.847123057619;8015.398845086758;8074.555899425353;8220.753377398449;8466.365022623204;12745.17156384832;12868.935655321664;12924.935375323063;13155;13297.601071967856;11178.329300242012;11370.260933039326;11575.479103440533;11682.357470339213;12241;11005.339679619248;11032.834507482556;11059.944700276768;11221.158413119212;11226.887731122584;11199.160062995144;11592.942035290107;11786.351750653796;11797;11863.466144023367;8237.31549472926;8343.624536895975;8438.257566290857;8448.746537603882;8604.655813767378;11519.481623327138;11582.305061696325;11681.299122052704;11700.941495292469;11765.647030589096 04:53:19 INFO - PROCESS | 16910 | |3;mootools.html;1268.56868664654;1441.0705095213584;1474.4102359056378;1605.1813575076715;1781.5189898727351;7908;8697.304215662747;8960.686375976842;9021.458712477248;9283.535823208846;8963.327750418712;9043.773905652362;9045.683401080963;9047.45715257085;9049.638014479413;2211.712477377943;2233.698450709158;2234.4190510467315;2235.307054813005;2236.317923033474;2125.426134943564;2176.9891150544227;2180.117052593694;2195.8462907596477;2221.044950671219;2195.7145571075816;2204.5370472200857;2205.4817117977263;2208.293346129239;2248.685184074231;2116.608427440928;2124.1928067334393;2128.8509804313703;2136.337735302046;2137.732783402075;2118.936431907045;2155.644318687415;2156.277646988261;2168.4362065862833;2176.847620666554;8443.282321002722;8640.524771137585;8785.692500762443;8951.73144805657;8971.506567138806;5181.870453238662;5315.6013299002725;5324.148136298174;5344;5355.705436201008;3230.628477725068;3290.19390249388;3313.155145437922;3328.683775041367;3382.30662714143;1052.447465080831;1077.6120596585224;1098.6703988803326;1101.3942331717603;1133.2973556395004;12677.936610316981;12701.047421443336;12732.936335318356;12812.231266124156;12815.743685126245;4242.427272318259;4391.538888416734;4441.600255976978;4514.119746649372;4545.840895568639;9922.206223502102;9976.201903847676;9995.100440960348;10003.14973227284;10012.299139060342;5108.514691104339;5109.821156259587;5117.309163262987;5135.38375394955;5139.331886854685;4031.4154447604933;4203.138356636882;4395.912081758411;4742.170120228946;4751.263554149044;3364.8317584120696;3704.499677630564;3727.6086010968456;3734.738568300247;3755.3615885299564;1066.3335415365398;1101.1686176936362;1109.9278546894427;1110.7722916802036;1115.642994241835;901.0223907060912;917.6283605139929;929.2194556572512;936.4007035497287;950.9714708558754;5824.271966004249;5951.345352011275;6144.815655530341;6363.840903977345;6397.4562162216735;403.07896456596535;409.6804492495858;414.4570612497638;422.06302009538774;425.6254496043462;3972.741771784825;4141.503019637603;4179.498460184797;4205.558416366299;4219.767912764827;11025.44872756375;11350.54597816078;11388.886111138949;11494.770104597861;11501.769964600828;11286.830697539543;11294.60468883585;11304.547818087349;11342.829857552144;11359.943200283946;7940.444168908237;8392.706255281037;8449;8463.74608761738;8471.322294216448;6232.252129744278;6246.094316324198;6405.103285539935;6429.903551446826;6499.350064993652;10018.248631352824;10495.21285903545;10515.94742026285;10603.992620701021;10612.522436490222;9639.421634701941;10780.514876830719;10906.945465272624;10911.454427278763;10937.45312734376;7573.9242607573215;7826;7866.331361834079;8005.07941586725;8226.794330141794;8255.545944972844;8482.109378515168;8628.22345988864;8729.083446238054;8860.512671803113;7766.495177813424;7981.640826162953;8016.478928869605;8027.678892844221;8294.543800091053;7850.097238817609;7866.410019248465;7951.602419879098;7962.800929976565;8055.919440805517;7305.379042781211;7321.6705248265025;7381.409487241115;7389.448215874511;7390.3718183952815;5102.3146261715165;5205.906759580379;5219.634625576173;5318.920216196838;5372.086745253395;5179.093658609803;5263.210518422267;5369.785208591613;5402;5512.035393805988 04:53:19 INFO - PROCESS | 16910 | |4;prototype.html;317.7029477438595;317.9189306726785;327.6068717538954;332.9550510681059;334.89450822990773;5225.477452254772;5277.815276465324;5297.523222909942;5299.417064122943;5338.306020217376;5178.378594568648;5211.609129315307;5220.564344805181;5283.260343551906;5283.2867562879;3856.2480316338324;3955.821988010532;4013.2174226025936;4050.4936882889638;4079.5920407959115;4069.3752529618378;4080.5919408059103;4094.5086589609286;4117.567655396185;4119.217348703752;4071.5521292657786;4086.2644723949825;4088.7342322748927;4104.527979282391;4105.117399759051;3886.2810380079495;3931.410288456726;4049.5950404959417;4059.3707975263883;4088.713790034699;3548.982255088708;3555.2356243407535;3560.3413368526903;3580.1944562473495;3585.229175727205;5090.854557724482;5093.541581257705;5095.643304968654;5101.591872650179;5165.276861239429;4443.37792709021;4618.630509559261;4642.489326174152;4659.510751371091;4682.859514214579;5348.866278343034;5413.971345444353;5482.80810171642;5485.451454854522;5487.314085739283;3903.8048097595292;3904.8438062477467;3926.9410958835642;3936.724429289951;3948;5405.351357837046;5547.694876781776;5648.971755141239;5684.578855286179;5692.715364231772;3890.2414029264587;3891.2217556488818;3897.162110146332;3903.33643280643;3904.6767173531703;3932.6067393260446;3958.663513601376;3965.325894597925;3975.92048159041;3978.264021156095;4494.955050449454;4560.612347950395;4616.469106052847;4626.907461850811;4638.1883170445035;5477.808276710296;5495.890082198333;5504.284443022381;5511.972440137773;5514.448555144453;1330.221820235154;1348.4606157536869;1350.5070649213162;1352.452256835983;1357.9864201358057;815.9922495717784;857.9613917373608;869.1438932651333;881.8677198420288;890.9287257019423;5083.313752643346;5226.555742761908;5249.110320284694;5249.692693603082;5253.185756207794;5465.316835395575;5511.255980442669;5534.501894829485;5642.097264437671;5656.2929633795775;5211.947880521222;5329.626926115135;5332.440093790174;5332.453588459303;5341.759620817073;2918.8978385756395;2971.257185703574;2993.880244790184;2995.9400811983637;3016.7284944355115;5771.220885180447;5776.855578610484;5806.564507661942;5815.156802263648;5848.678322692208;5483.259759932438;5665.3768085510565;5703.971480142655;5706.600537962386;5712.22920894524;5693.829185124453;5752.683602401824;5822.592418530747;5840.737166827418;5852.092925596539;5424.1321388577635;5649.54803615718;5651.660900345993;5663.969776169894;5689.459501347365;5583.525400341016;5598.244237027949;5637;5638.7462564185535;5641.802536911188;5819.970900145641;5826.621269617462;5854.853628659318;5903.527717782481;5907.113932910098;3728.3289007978824;3928.135810121769;3947.184295224229;4033.5966403360603;4041.8989525262105;5612.765191657829;5618;5692.971535142297;5710;5713.514351280188;5516.531094856982;5529.640573362719;5551.361593416647;5590.5248053915875;5593.720313984203;5375.435579264277;5409.7285697254465;5481.890362192814;5503.834884953458;5510.724463776715;5394.676319420847;5430.13117901134;5469.945300546943;5472.452754724496;5490.780368785364;5382.784688612412;5392.487713667196;5507.256520369699;5569.805056822992;5581.832545023656;5378.2739330189925;5388.784448622011;5390.541803946551;5434.701091440009;5456.127019676833 04:53:19 INFO - PROCESS | 16910 | |5;yui.html;710.6127160697425;741.0995640297039;777.1606664802015;779.7972527142945;815.164456432157;14324.856751432482;15748.448804291853;15757.369705211779;15783.28975196116;15790.921045394785;14795.26023698816;14921.552353429388;14968.17675027873;14971.25143742814;14980.475683351086;655.9475241980654;672.559473544829;795.7533164718956;816.930560902324;819.8237378963522;786.8347646994138;814.071957967917;815.8816971539123;817.0195765081896;819.868820988639;873.9475631462133;875.8029443375221;876.0494863073573;876.1107475911955;876.4171825735878;876.0626130040858;876.1545108969843;876.2770714160811;876.3514998900831;877.4165180155189;501.48801363887543;522.1071966936543;603.4749767702083;629.0784001437916;638.578538164809;13917.52061984504;13949.790753138712;13953.720925581532;13992.650183745487;14013;13120.86879131206;13798.241096739675;13813.171209727449;13816.171029738147;13931.233782141979;12671.556495522706;12965.321585727053;13080.86919130806;13135.211887286794;13343.666408339772;4139.482564679415;4179.707420480568;4180.122174343361;4260.786960651986;4321.675874309408;76719.61640191819;79757.60121199414;81165.18834811635;81243.59378203072;81575.5921220396;10106.494675266207;10383.636572719919;10432.113270371952;10670.573177072985;11150.553977840958;20615.69076463854;20638.452116091354;20703;20824.47938801542;20831.791682083287;7715.344195743424;7969.880451793228;8088.797780055545;8208.753737387888;8229.300509456643;4428.092241090569;4561.315802629566;4649.642735118893;4650.162970665245;4659.487456379796;3438.673326034023;3551.236484155919;3561.94657080144;3567.108222944264;3567.5897271813556;619.7118339971935;620.0667994667996;622.9408206220402;625.7309356976452;645.470714014513;532.6218384946653;549.6682182826598;556.0584507952965;612.537534161714;683.4256836743758;8523.914760852436;9611.855822162674;9628.133467987775;9660.792400949882;9745.756356091013;545.1332381513333;645.7965740791635;668.4151367553391;668.9163854518185;674.2179072276136;4393.51671316155;4616.053708989649;4670.929936050894;4673.3690951721765;4743.501932297059;66786;70157;112888;120667;123434.38282808529;101544.49227753814;101670.7326827704;104194;105130.47434762931;107607.46196268969;87291;87653.56173219094;88805;88830.45204123552;89408.5529572361;8778.692745753868;9141.817163656822;9164.770880728036;9219.953900230725;9254.35219534653;51334.229986549486;52962.47037529575;54038.45961540334;54294;54775.17837232365;77878.6106069466;78271.60864195642;78964.21035789799;79478.60260698659;82858;10619.94690026545;10697.251192416456;10751.569937202737;11311.208215425171;11921.34432606215;12665.683357916127;12736.363181840685;13052.15161014531;13200.14199077057;13669.111507751964;11768.411579420823;12215.755684886075;12270.32513211782;12309;12713.618591441902;11581.536738530365;13176.143550669176;13278.734425311633;13636.181829090287;14299.356528956014;13324.866751332362;13499.122557033761;13788;14314.212718300178;14350;10359.84460233082;10781.353118812896;10978.890211097787;11384.260023098803;11398.430078495876;11243.269187502787;11485.19603627738;11898.821517677416;11998.460069296729;12000.57997970067 04:53:19 INFO - PROCESS | 16910 | __end_tp_report 04:53:19 INFO - PROCESS | 16910 | __start_cc_report 04:53:19 INFO - PROCESS | 16910 | _x_x_mozilla_cycle_collect,1208 04:53:19 INFO - PROCESS | 16910 | __end_cc_report 04:53:19 INFO - PROCESS | 16910 | __startTimestamp1476791599103__endTimestamp 04:53:19 INFO - PROCESS | 16910 | 04:53:19 INFO - PROCESS | 16910 | ------- Summary: start ------- 04:53:19 INFO - PROCESS | 16910 | Number of tests: 6 04:53:19 INFO - PROCESS | 16910 | 04:53:19 INFO - PROCESS | 16910 | [#0] dojo.html Cycles:165 Average:5202.18 Median:5393.51 stddev:561.42 (10.4%) stddev-sans-first:536.73 04:53:19 INFO - PROCESS | 16910 | Values: 3033.0 3059.3 3088.9 3101.9 3102.9 5087.9 5191.0 5209.2 5295.4 5353.7 5213.1 5218.6 5327.2 5336.5 5367.1 4728.9 4747.3 4795.5 4806.1 4826.6 4810.8 4856.3 4873.3 4877.2 4937.2 4651.4 4824.6 4830.8 4832.1 4932.5 4687.2 4712.1 4747.2 4748.5 4773.1 4735.1 4737.0 4753.8 4775.9 4804.1 5193.8 5232.2 5242.1 5242.9 5245.6 5455.4 5464.4 5505.7 5532.1 5567.2 5577.6 5586.6 5597.0 5654.4 5664.5 5237.7 5243.9 5248.4 5253.1 5318.5 5489.7 5547.5 5561.7 5670.9 5682.6 5463.9 5502.6 5521.1 5528.1 5596.2 5566.8 5566.9 5603.8 5610.2 5616.4 5439.1 5591.2 5592.5 5596.1 5599.8 5474.5 5478.5 5505.9 5525.2 5612.4 4334.7 4369.9 4377.2 4381.7 4385.5 3857.1 3871.7 3871.9 3916.4 3922.9 5209.8 5283.7 5290.5 5295.0 5299.9 5513.5 5569.9 5635.8 5636.4 5719.4 5313.6 5333.8 5359.7 5360.3 5361.9 4823.7 4840.2 4841.1 4845.7 4902.9 5667.1 5678.7 5721.8 5726.7 5731.2 5573.6 5576.6 5579.8 5581.1 5634.2 5662.7 5667.5 5713.0 5713.5 5735.3 5386.5 5397.7 5418.8 5471.2 5519.8 5577.2 5627.4 5631.4 5682.1 5702.3 5493.7 5499.2 5504.2 5506.0 5525.4 5367.0 5413.8 5416.7 5515.7 5587.1 5393.5 5431.2 5440.4 5498.3 5509.2 5517.6 5530.1 5533.9 5534.5 5536.3 5305.3 5314.1 5347.8 5351.3 5386.6 04:53:19 INFO - PROCESS | 16910 | 04:53:19 INFO - PROCESS | 16910 | [#1] ext.html Cycles:180 Average:55809.32 Median:19780.26 stddev:108020.13 (546.1%) stddev-sans-first:108243.54 04:53:19 INFO - PROCESS | 16910 | Values: 571.2 593.0 597.6 627.8 657.3 31902.2 35101.8 35155.1 35192.6 35214.3 35513.1 45014.8 45230.8 45304.0 49363.0 8740.6 8752.2 8873.8 8897.8 8898.6 8604.3 8689.2 8693.2 8696.2 8702.6 8136.0 8377.0 10566.8 10762.2 10787.7 10739.0 10820.1 10838.6 10839.5 10849.9 10501.4 10545.0 10555.7 10577.8 10579.2 42301.2 42512.1 42596.0 42726.0 42782.4 3204.9 3318.5 3436.3 3576.4 3580.4 31746.2 32030.4 32055.5 32127.7 32205.0 3491.9 3617.5 3694.9 3765.8 3888.7 284016.0 284435.0 284654.0 285417.0 286949.0 57581.1 57893.0 58038.4 58062.4 58146.1 60124.7 60505.4 60842.0 60865.7 60901.7 15051.8 15227.3 15242.0 15316.9 15318.5 11107.5 11200.6 11202.4 11204.0 11204.4 15090.2 16703.2 17402.7 17459.0 17684.0 4957.6 5789.3 5925.3 6034.2 6238.3 864.8 942.3 975.6 1043.3 1116.1 31343.4 32015.8 32036.4 32090.5 32800.0 1016.8 1043.0 1072.4 1074.6 1133.0 15316.6 16496.5 16501.8 16560.3 16961.5 441755.0 446797.0 448194.0 448244.0 449612.0 42994.6 43660.0 54811.7 56366.0 56534.4 1284.6 1324.7 1329.2 1350.8 1358.4 30172.6 32779.7 33133.3 33277.2 33436.5 45907.0 46273.0 46344.3 46364.5 46456.5 385454.0 392917.0 395634.0 560090.0 560709.0 27338.5 27551.4 27663.3 27681.4 27725.7 46913.0 47154.5 47196.0 47258.0 48006.0 39821.0 40219.6 41282.8 41547.4 43736.8 39271.8 39592.8 40056.0 40596.6 40960.6 39561.8 40612.8 41210.8 42578.4 43149.6 30845.4 35105.2 35565.5 35943.0 36488.3 26681.7 26847.7 26940.3 26954.9 27137.3 04:53:19 INFO - PROCESS | 16910 | 04:53:19 INFO - PROCESS | 16910 | [#2] jquery.html Cycles:180 Average:26198.75 Median:12762.36 stddev:68593.03 (537.5%) stddev-sans-first:68758.02 04:53:19 INFO - PROCESS | 16910 | Values: 362.0 373.9 375.8 378.5 395.6 14147.5 18364.2 18869.2 19148.8 20447.0 18580.8 19180.4 19222.0 19346.5 19360.9 5269.3 5520.5 5574.0 5578.8 5601.9 4057.6 4266.0 4304.6 5469.3 5498.6 6123.8 6148.5 6299.3 6303.8 6315.0 6168.4 6222.2 6271.4 6284.5 6312.7 5535.0 5545.7 5548.2 5549.3 5551.6 22548.9 23244.7 23405.8 23431.3 23580.4 2224.1 2263.7 2280.1 2568.6 3001.8 13437.7 14130.4 14389.6 14774.3 15066.6 1814.0 1874.1 1936.5 1960.0 1998.6 75643.6 76735.6 76789.6 79266.0 79872.2 10108.3 10326.9 10327.5 10416.8 10627.8 14320.2 14351.3 14351.4 14354.4 14363.2 7298.5 7506.8 7573.5 7699.2 7725.7 7141.7 7177.1 7334.5 7354.5 7424.3 6150.9 6295.8 6302.9 6394.0 6461.9 1783.0 1841.6 1879.9 1893.0 1902.7 912.1 994.9 1014.3 1030.3 1054.8 19142.8 20167.9 20247.4 20395.6 20516.3 977.2 1023.6 1035.4 1038.2 1058.4 10498.3 10935.7 11064.5 11084.2 11308.4 392369.0 409521.0 422793.0 427008.0 429042.0 75031.2 76430.6 77009.6 77180.6 77790.2 1026.0 1042.4 1054.9 1064.6 1067.2 16953.3 17134.6 17608.9 17762.6 18031.9 37557.6 38669.4 38832.0 39064.8 39168.8 50389.7 50661.5 51050.7 51206.5 52383.5 7643.8 8015.4 8074.6 8220.8 8466.4 12745.2 12868.9 12924.9 13155.0 13297.6 11178.3 11370.3 11575.5 11682.4 12241.0 11005.3 11032.8 11059.9 11221.2 11226.9 11199.2 11592.9 11786.4 11797.0 11863.5 8237.3 8343.6 8438.3 8448.7 8604.7 11519.5 11582.3 11681.3 11700.9 11765.6 04:53:19 INFO - PROCESS | 16910 | 04:53:19 INFO - PROCESS | 16910 | [#3] mootools.html Cycles:180 Average:5850.72 Median:4418.76 stddev:3471.18 (78.6%) stddev-sans-first:3463.84 04:53:19 INFO - PROCESS | 16910 | Values: 1268.6 1441.1 1474.4 1605.2 1781.5 7908.0 8697.3 8960.7 9021.5 9283.5 8963.3 9043.8 9045.7 9047.5 9049.6 2211.7 2233.7 2234.4 2235.3 2236.3 2125.4 2177.0 2180.1 2195.8 2221.0 2195.7 2204.5 2205.5 2208.3 2248.7 2116.6 2124.2 2128.9 2136.3 2137.7 2118.9 2155.6 2156.3 2168.4 2176.8 8443.3 8640.5 8785.7 8951.7 8971.5 5181.9 5315.6 5324.1 5344.0 5355.7 3230.6 3290.2 3313.2 3328.7 3382.3 1052.4 1077.6 1098.7 1101.4 1133.3 12677.9 12701.0 12732.9 12812.2 12815.7 4242.4 4391.5 4441.6 4514.1 4545.8 9922.2 9976.2 9995.1 10003.1 10012.3 5108.5 5109.8 5117.3 5135.4 5139.3 4031.4 4203.1 4395.9 4742.2 4751.3 3364.8 3704.5 3727.6 3734.7 3755.4 1066.3 1101.2 1109.9 1110.8 1115.6 901.0 917.6 929.2 936.4 951.0 5824.3 5951.3 6144.8 6363.8 6397.5 403.1 409.7 414.5 422.1 425.6 3972.7 4141.5 4179.5 4205.6 4219.8 11025.4 11350.5 11388.9 11494.8 11501.8 11286.8 11294.6 11304.5 11342.8 11359.9 7940.4 8392.7 8449.0 8463.7 8471.3 6232.3 6246.1 6405.1 6429.9 6499.4 10018.2 10495.2 10515.9 10604.0 10612.5 9639.4 10780.5 10906.9 10911.5 10937.5 7573.9 7826.0 7866.3 8005.1 8226.8 8255.5 8482.1 8628.2 8729.1 8860.5 7766.5 7981.6 8016.5 8027.7 8294.5 7850.1 7866.4 7951.6 7962.8 8055.9 7305.4 7321.7 7381.4 7389.4 7390.4 5102.3 5205.9 5219.6 5318.9 5372.1 5179.1 5263.2 5369.8 5402.0 5512.0 04:53:19 INFO - PROCESS | 16910 | 04:53:19 INFO - PROCESS | 16910 | [#4] prototype.html Cycles:180 Average:4606.00 Median:5331.03 stddev:1375.24 (25.8%) stddev-sans-first:1340.91 04:53:19 INFO - PROCESS | 16910 | Values: 317.7 317.9 327.6 333.0 334.9 5225.5 5277.8 5297.5 5299.4 5338.3 5178.4 5211.6 5220.6 5283.3 5283.3 3856.2 3955.8 4013.2 4050.5 4079.6 4069.4 4080.6 4094.5 4117.6 4119.2 4071.6 4086.3 4088.7 4104.5 4105.1 3886.3 3931.4 4049.6 4059.4 4088.7 3549.0 3555.2 3560.3 3580.2 3585.2 5090.9 5093.5 5095.6 5101.6 5165.3 4443.4 4618.6 4642.5 4659.5 4682.9 5348.9 5414.0 5482.8 5485.5 5487.3 3903.8 3904.8 3926.9 3936.7 3948.0 5405.4 5547.7 5649.0 5684.6 5692.7 3890.2 3891.2 3897.2 3903.3 3904.7 3932.6 3958.7 3965.3 3975.9 3978.3 4495.0 4560.6 4616.5 4626.9 4638.2 5477.8 5495.9 5504.3 5512.0 5514.4 1330.2 1348.5 1350.5 1352.5 1358.0 816.0 858.0 869.1 881.9 890.9 5083.3 5226.6 5249.1 5249.7 5253.2 5465.3 5511.3 5534.5 5642.1 5656.3 5211.9 5329.6 5332.4 5332.5 5341.8 2918.9 2971.3 2993.9 2995.9 3016.7 5771.2 5776.9 5806.6 5815.2 5848.7 5483.3 5665.4 5704.0 5706.6 5712.2 5693.8 5752.7 5822.6 5840.7 5852.1 5424.1 5649.5 5651.7 5664.0 5689.5 5583.5 5598.2 5637.0 5638.7 5641.8 5820.0 5826.6 5854.9 5903.5 5907.1 3728.3 3928.1 3947.2 4033.6 4041.9 5612.8 5618.0 5693.0 5710.0 5713.5 5516.5 5529.6 5551.4 5590.5 5593.7 5375.4 5409.7 5481.9 5503.8 5510.7 5394.7 5430.1 5469.9 5472.5 5490.8 5382.8 5392.5 5507.3 5569.8 5581.8 5378.3 5388.8 5390.5 5434.7 5456.1 04:53:19 INFO - PROCESS | 16910 | 04:53:19 INFO - PROCESS | 16910 | [#5] yui.html Cycles:180 Average:20634.93 Median:4588.68 stddev:30009.00 (654.0%) stddev-sans-first:30055.89 04:53:19 INFO - PROCESS | 16910 | Values: 710.6 741.1 777.2 779.8 815.2 14324.9 15748.4 15757.4 15783.3 15790.9 14795.3 14921.6 14968.2 14971.3 14980.5 655.9 672.6 795.8 816.9 819.8 786.8 814.1 815.9 817.0 819.9 873.9 875.8 876.0 876.1 876.4 876.1 876.2 876.3 876.4 877.4 501.5 522.1 603.5 629.1 638.6 13917.5 13949.8 13953.7 13992.7 14013.0 13120.9 13798.2 13813.2 13816.2 13931.2 12671.6 12965.3 13080.9 13135.2 13343.7 4139.5 4179.7 4180.1 4260.8 4321.7 76719.6 79757.6 81165.2 81243.6 81575.6 10106.5 10383.6 10432.1 10670.6 11150.6 20615.7 20638.5 20703.0 20824.5 20831.8 7715.3 7969.9 8088.8 8208.8 8229.3 4428.1 4561.3 4649.6 4650.2 4659.5 3438.7 3551.2 3561.9 3567.1 3567.6 619.7 620.1 622.9 625.7 645.5 532.6 549.7 556.1 612.5 683.4 8523.9 9611.9 9628.1 9660.8 9745.8 545.1 645.8 668.4 668.9 674.2 4393.5 4616.1 4670.9 4673.4 4743.5 66786.0 70157.0 112888.0 120667.0 123434.4 101544.5 101670.7 104194.0 105130.5 107607.5 87291.0 87653.6 88805.0 88830.5 89408.6 8778.7 9141.8 9164.8 9220.0 9254.4 51334.2 52962.5 54038.5 54294.0 54775.2 77878.6 78271.6 78964.2 79478.6 82858.0 10619.9 10697.3 10751.6 11311.2 11921.3 12665.7 12736.4 13052.2 13200.1 13669.1 11768.4 12215.8 12270.3 12309.0 12713.6 11581.5 13176.1 13278.7 13636.2 14299.4 13324.9 13499.1 13788.0 14314.2 14350.0 10359.8 10781.4 10978.9 11384.3 11398.4 11243.3 11485.2 11898.8 11998.5 12000.6 04:53:19 INFO - PROCESS | 16910 | -------- Summary: end -------- 04:53:19 INFO - PROCESS | 16910 | 04:53:20 INFO - TEST-INFO | 16910: exit 0 04:53:20 INFO - TEST-OK | dromaeo_css | took 1118872ms 04:53:20 INFO - TEST-START | kraken 04:53:20 INFO - operating with platform_type : linux_ 04:53:20 INFO - Initialising browser for kraken test... 04:53:20 INFO - TEST-INFO | started process 17215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvrexl9/profile http://localhost:51708/getInfo.html) 04:53:24 INFO - PROCESS | 17215 | __metrics Screen width/height:1600/1200 04:53:24 INFO - PROCESS | 17215 | colorDepth:24 04:53:24 INFO - PROCESS | 17215 | Browser inner width/height: 1024/697 04:53:24 INFO - PROCESS | 17215 | __metrics 04:53:25 INFO - PROCESS | 17215 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:53:25 INFO - PROCESS | 17215 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:53:26 INFO - PROCESS | 17215 | console.error: PushService: 04:53:26 INFO - PROCESS | 17215 | stateChangeProcessEnqueue: Error transitioning state 04:53:26 INFO - PROCESS | 17215 | UnknownError 04:53:27 INFO - TEST-INFO | 17215: exit 0 04:53:27 INFO - Browser initialized. 04:53:27 INFO - Running cycle 1/1 for kraken test... 04:53:27 INFO - TEST-INFO | started process 17297 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvrexl9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:53:39 INFO - PROCESS | 17297 | RSS: Main: 171847680 04:53:39 INFO - PROCESS | 17297 | 04:53:41 INFO - PROCESS | 17297 | Cycle 1(1): loaded http://localhost:51708/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51708/tests/kraken/driver.html?testName=audio-beat-detection) 04:53:42 INFO - PROCESS | 17297 | RSS: Main: 228872192 04:53:42 INFO - PROCESS | 17297 | 04:53:45 INFO - PROCESS | 17297 | Cycle 1(1): loaded http://localhost:51708/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51708/tests/kraken/driver.html?testName=audio-dft) 04:53:45 INFO - PROCESS | 17297 | RSS: Main: 216195072 04:53:45 INFO - PROCESS | 17297 | 04:53:48 INFO - PROCESS | 17297 | Cycle 1(1): loaded http://localhost:51708/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51708/tests/kraken/driver.html?testName=audio-fft) 04:53:49 INFO - PROCESS | 17297 | RSS: Main: 297570304 04:53:49 INFO - PROCESS | 17297 | 04:53:51 INFO - PROCESS | 17297 | Cycle 1(1): loaded http://localhost:51708/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51708/tests/kraken/driver.html?testName=audio-oscillator) 04:53:52 INFO - PROCESS | 17297 | RSS: Main: 208896000 04:53:52 INFO - PROCESS | 17297 | 04:53:54 INFO - PROCESS | 17297 | Cycle 1(1): loaded http://localhost:51708/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51708/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:53:55 INFO - PROCESS | 17297 | RSS: Main: 211550208 04:53:55 INFO - PROCESS | 17297 | 04:53:58 INFO - PROCESS | 17297 | Cycle 1(1): loaded http://localhost:51708/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51708/tests/kraken/driver.html?testName=imaging-darkroom) 04:53:58 INFO - PROCESS | 17297 | RSS: Main: 248377344 04:53:58 INFO - PROCESS | 17297 | 04:54:01 INFO - PROCESS | 17297 | Cycle 1(1): loaded http://localhost:51708/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51708/tests/kraken/driver.html?testName=imaging-desaturate) 04:54:02 INFO - PROCESS | 17297 | RSS: Main: 246714368 04:54:02 INFO - PROCESS | 17297 | 04:54:05 INFO - PROCESS | 17297 | Cycle 1(1): loaded http://localhost:51708/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51708/tests/kraken/driver.html?testName=json-parse-financial) 04:54:05 INFO - PROCESS | 17297 | RSS: Main: 246095872 04:54:05 INFO - PROCESS | 17297 | 04:54:07 INFO - PROCESS | 17297 | Cycle 1(1): loaded http://localhost:51708/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51708/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:54:07 INFO - PROCESS | 17297 | RSS: Main: 209174528 04:54:07 INFO - PROCESS | 17297 | 04:54:09 INFO - PROCESS | 17297 | Cycle 1(1): loaded http://localhost:51708/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51708/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:54:10 INFO - PROCESS | 17297 | RSS: Main: 216866816 04:54:10 INFO - PROCESS | 17297 | 04:54:12 INFO - PROCESS | 17297 | Cycle 1(1): loaded http://localhost:51708/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51708/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:54:12 INFO - PROCESS | 17297 | RSS: Main: 225550336 04:54:12 INFO - PROCESS | 17297 | 04:54:15 INFO - PROCESS | 17297 | Cycle 1(1): loaded http://localhost:51708/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51708/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:54:16 INFO - PROCESS | 17297 | RSS: Main: 231403520 04:54:16 INFO - PROCESS | 17297 | 04:54:19 INFO - PROCESS | 17297 | Cycle 1(1): loaded http://localhost:51708/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51708/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:54:19 INFO - PROCESS | 17297 | RSS: Main: 231788544 04:54:19 INFO - PROCESS | 17297 | 04:54:21 INFO - PROCESS | 17297 | Cycle 1(1): loaded http://localhost:51708/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51708/tests/kraken/driver.html?testName=ai-astar) 04:54:21 INFO - PROCESS | 17297 | RSS: Main: 281866240 04:54:21 INFO - PROCESS | 17297 | 04:54:21 INFO - PROCESS | 17297 | __start_tp_report 04:54:21 INFO - PROCESS | 17297 | _x_x_mozilla_page_load 04:54:21 INFO - PROCESS | 17297 | _x_x_mozilla_page_load_details 04:54:21 INFO - PROCESS | 17297 | |i|pagename|runs| 04:54:21 INFO - PROCESS | 17297 | |0;ai-astar;102;110;110;111;112;110;112;109;109;109 04:54:21 INFO - PROCESS | 17297 | |1;audio-beat-detection;152;122;122;166;123;127;120;121;149;134 04:54:21 INFO - PROCESS | 17297 | |2;audio-dft;163;162;162;162;162;163;163;162;162;161 04:54:21 INFO - PROCESS | 17297 | |3;audio-fft;74;75;74;110;75;75;75;75;98;75 04:54:21 INFO - PROCESS | 17297 | |4;audio-oscillator;82;82;117;82;82;83;111;82;81;106 04:54:21 INFO - PROCESS | 17297 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;117;117;119 04:54:21 INFO - PROCESS | 17297 | |6;imaging-darkroom;147;145;145;146;147;146;147;147;146;145 04:54:21 INFO - PROCESS | 17297 | |7;imaging-desaturate;84;85;85;84;85;85;84;84;84;84 04:54:21 INFO - PROCESS | 17297 | |8;json-parse-financial;53;52;51;51;52;53;52;52;52;52 04:54:21 INFO - PROCESS | 17297 | |9;json-stringify-tinderbox;58;59;58;59;59;59;59;59;59;59 04:54:21 INFO - PROCESS | 17297 | |10;stanford-crypto-aes;80;81;81;80;79;89;82;79;79;80 04:54:21 INFO - PROCESS | 17297 | |11;stanford-crypto-ccm;133;145;134;133;129;133;141;132;176;131 04:54:21 INFO - PROCESS | 17297 | |12;stanford-crypto-pbkdf2;177;171;168;170;168;167;168;169;168;170 04:54:21 INFO - PROCESS | 17297 | |13;stanford-crypto-sha256-iterative;65;66;68;67;66;66;65;66;71;70 04:54:21 INFO - PROCESS | 17297 | __end_tp_report 04:54:21 INFO - PROCESS | 17297 | __start_cc_report 04:54:21 INFO - PROCESS | 17297 | _x_x_mozilla_cycle_collect,1693 04:54:21 INFO - PROCESS | 17297 | __end_cc_report 04:54:21 INFO - PROCESS | 17297 | __startTimestamp1476791661631__endTimestamp 04:54:21 INFO - PROCESS | 17297 | 04:54:21 INFO - PROCESS | 17297 | ------- Summary: start ------- 04:54:21 INFO - PROCESS | 17297 | Number of tests: 14 04:54:21 INFO - PROCESS | 17297 | 04:54:21 INFO - PROCESS | 17297 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:2.84 (2.6%) stddev-sans-first:1.20 04:54:21 INFO - PROCESS | 17297 | Values: 102.0 110.0 110.0 111.0 112.0 110.0 112.0 109.0 109.0 109.0 04:54:21 INFO - PROCESS | 17297 | 04:54:21 INFO - PROCESS | 17297 | [#1] audio-beat-detection Cycles:10 Average:133.60 Median:130.50 stddev:16.31 (12.5%) stddev-sans-first:15.88 04:54:21 INFO - PROCESS | 17297 | Values: 152.0 122.0 122.0 166.0 123.0 127.0 120.0 121.0 149.0 134.0 04:54:21 INFO - PROCESS | 17297 | 04:54:21 INFO - PROCESS | 17297 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 04:54:21 INFO - PROCESS | 17297 | Values: 163.0 162.0 162.0 162.0 162.0 163.0 163.0 162.0 162.0 161.0 04:54:21 INFO - PROCESS | 17297 | 04:54:21 INFO - PROCESS | 17297 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.00 stddev:12.66 (16.9%) stddev-sans-first:13.20 04:54:21 INFO - PROCESS | 17297 | Values: 74.0 75.0 74.0 110.0 75.0 75.0 75.0 75.0 98.0 75.0 04:54:21 INFO - PROCESS | 17297 | 04:54:21 INFO - PROCESS | 17297 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:82.00 stddev:14.41 (17.6%) stddev-sans-first:14.93 04:54:21 INFO - PROCESS | 17297 | Values: 82.0 82.0 117.0 82.0 82.0 83.0 111.0 82.0 81.0 106.0 04:54:21 INFO - PROCESS | 17297 | 04:54:21 INFO - PROCESS | 17297 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 04:54:21 INFO - PROCESS | 17297 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 119.0 04:54:21 INFO - PROCESS | 17297 | 04:54:21 INFO - PROCESS | 17297 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.50 stddev:0.88 (0.6%) stddev-sans-first:0.87 04:54:21 INFO - PROCESS | 17297 | Values: 147.0 145.0 145.0 146.0 147.0 146.0 147.0 147.0 146.0 145.0 04:54:21 INFO - PROCESS | 17297 | 04:54:21 INFO - PROCESS | 17297 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 04:54:21 INFO - PROCESS | 17297 | Values: 84.0 85.0 85.0 84.0 85.0 85.0 84.0 84.0 84.0 84.0 04:54:21 INFO - PROCESS | 17297 | 04:54:21 INFO - PROCESS | 17297 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:0.67 (1.3%) stddev-sans-first:0.60 04:54:21 INFO - PROCESS | 17297 | Values: 53.0 52.0 51.0 51.0 52.0 53.0 52.0 52.0 52.0 52.0 04:54:21 INFO - PROCESS | 17297 | 04:54:21 INFO - PROCESS | 17297 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 04:54:21 INFO - PROCESS | 17297 | Values: 58.0 59.0 58.0 59.0 59.0 59.0 59.0 59.0 59.0 59.0 04:54:21 INFO - PROCESS | 17297 | 04:54:21 INFO - PROCESS | 17297 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.50 stddev:2.98 (3.7%) stddev-sans-first:3.14 04:54:21 INFO - PROCESS | 17297 | Values: 80.0 81.0 81.0 80.0 79.0 89.0 82.0 79.0 79.0 80.0 04:54:21 INFO - PROCESS | 17297 | 04:54:21 INFO - PROCESS | 17297 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:133.50 stddev:13.96 (10.5%) stddev-sans-first:14.65 04:54:21 INFO - PROCESS | 17297 | Values: 133.0 145.0 134.0 133.0 129.0 133.0 141.0 132.0 176.0 131.0 04:54:21 INFO - PROCESS | 17297 | 04:54:21 INFO - PROCESS | 17297 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:169.50 stddev:2.88 (1.7%) stddev-sans-first:1.30 04:54:21 INFO - PROCESS | 17297 | Values: 177.0 171.0 168.0 170.0 168.0 167.0 168.0 169.0 168.0 170.0 04:54:21 INFO - PROCESS | 17297 | 04:54:21 INFO - PROCESS | 17297 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:66.50 stddev:2.05 (3.1%) stddev-sans-first:2.05 04:54:21 INFO - PROCESS | 17297 | Values: 65.0 66.0 68.0 67.0 66.0 66.0 65.0 66.0 71.0 70.0 04:54:21 INFO - PROCESS | 17297 | -------- Summary: end -------- 04:54:21 INFO - PROCESS | 17297 | 04:54:22 INFO - TEST-INFO | 17297: exit 0 04:54:22 INFO - TEST-OK | kraken | took 62816ms 04:54:22 INFO - SUITE-END | took 1181s 04:54:23 INFO - Completed test suite (00:19:42) 04:54:23 INFO - javascript benchmark 04:54:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3032.984835075825, 3059.3116548776516, 3088.891888783893, 3101.860416281267, 3102.9379412411754, 5087.898242035167, 5191.0, 5209.192575150848, 5295.443978382272, 5353.73231338433, 5213.087709650806, 5218.608604354669, 5327.200919862023, 5336.493033161843, 5367.087595108831, 4728.881777955544, 4747.287906813971, 4795.520447955194, 4806.134895718769, 4826.61387089032, 4810.759462026902, 4856.344393506866, 4873.293372460991, 4877.244027175776, 4937.1606826839525, 4651.395318608593, 4824.5899098576665, 4830.758462076918, 4832.05774873898, 4932.531409516108, 4687.20317546018, 4712.104700106968, 4747.240441529373, 4748.5251474852585, 4773.140834649762, 4735.100330937111, 4736.976315118437, 4753.786079626425, 4775.856724298276, 4804.0872234275375, 5193.792248310063, 5232.1628539433505, 5242.056429842627, 5242.895142097137, 5245.606579506514, 5455.399906010336, 5464.398916119224, 5505.697186654733, 5532.087205611109, 5567.192757050246, 5577.553795696334, 5586.608937374385, 5596.972015139939, 5654.434556544354, 5664.518515926151, 5237.685738855681, 5243.895122097575, 5248.448912864171, 5253.133233016548, 5318.547923426552, 5489.6980666062955, 5547.472990065938, 5561.749721262553, 5670.858228544237, 5682.602217844711, 5463.863403414946, 5502.614816962774, 5521.089020311603, 5528.115501519737, 5596.1605759136455, 5566.832995010156, 5566.888662226733, 5603.80386686464, 5610.186522954149, 5616.410276920946, 5439.129739241703, 5591.245181900473, 5592.5246354059545, 5596.076647353141, 5599.776008959678, 5474.507294343528, 5478.534324582375, 5505.917411238835, 5525.171224316305, 5612.382637909826, 4334.718243314174, 4369.890752731207, 4377.233984052778, 4381.671374646914, 4385.51759306476, 3857.1321452672923, 3871.709621778378, 3871.9032024199055, 3916.412538119305, 3922.882313530599, 5209.817656382009, 5283.656562323436, 5290.497402746733, 5294.97352513235, 5299.867503312448, 5513.531349835229, 5569.916451253234, 5635.802746903921, 5636.351819540723, 5719.399463056402, 5313.601479888946, 5333.839984800462, 5359.705216213146, 5360.276362691065, 5361.892762144736, 4823.734694591761, 4840.2255639098275, 4841.080194762983, 4845.6608037437045, 4902.8774280643265, 5667.064934285879, 5678.744456499468, 5721.799737009184, 5726.656400615976, 5731.168980497721, 5573.637713548606, 5576.60963732551, 5579.832605021856, 5581.134924086773, 5634.211210430625, 5662.66024038559, 5667.546596272371, 5713.0, 5713.514351280188, 5735.283089613798, 5386.461353864583, 5397.730113494388, 5418.810341638024, 5471.179323101566, 5519.751611177587, 5577.163425486047, 5627.352854421794, 5631.4368563145, 5682.090865461506, 5702.287214098238, 5493.670379777226, 5499.202615620633, 5504.174373843955, 5506.0, 5525.392206857162, 5367.033933891937, 5413.83758487246, 5416.729163541729, 5515.69663668486, 5587.106063029895, 5393.514583687487, 5431.23962645222, 5440.374356949002, 5498.3127109111365, 5509.228707980806, 5517.5585953124455, 5530.142827861688, 5533.944660553343, 5534.501894829485, 5536.252605898313, 5305.31030965972, 5314.1497360422145, 5347.839564813062, 5351.304330437174, 5386.569074474111], "value": 5166.041241355056, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.1759768350889, 592.9673867937263, 597.6264834478451, 627.7583130494758, 657.3426573426574, 31902.20244493886, 35101.824490877574, 35155.12112197196, 35192.64807351926, 35214.2957140857, 35513.11217219571, 45014.77492612533, 45230.7738461308, 45304.0, 49363.0, 8740.562971851414, 8752.168543988311, 8873.778155546132, 8897.77755556113, 8898.555072246394, 8604.31165506758, 8689.217970382664, 8693.217610415062, 8696.17386348299, 8702.608382622766, 8135.959320203391, 8377.0, 10566.788664226711, 10762.192835537366, 10787.67636970892, 10739.0, 10820.08029317509, 10838.620648277272, 10839.512221949992, 10849.891501084967, 10501.36991780488, 10545.0, 10555.683329500127, 10577.84133238002, 10579.153667706565, 42301.15397692029, 42512.149757005, 42596.0, 42726.0, 42782.358264626055, 3204.9198770030703, 3318.4856347266214, 3436.29555941034, 3576.409892367756, 3580.445031020196, 31746.206344841565, 32030.359392812246, 32055.51916721251, 32127.678723212703, 32205.033848984567, 3491.8777842775635, 3617.5297211362354, 3694.9445758313645, 3765.8305376258136, 3888.727789054767, 284016.0, 284434.9999999979, 284654.0, 285417.0, 286949.0, 57581.13628295579, 57893.0, 58038.419615804145, 58062.4193758057, 58146.127808082914, 60124.69937650371, 60505.411552978054, 60842.0, 60865.69567152136, 60901.69549152226, 15051.774223386657, 15227.314770835339, 15242.0, 15316.923415383075, 15318.540443786482, 11107.500162492546, 11200.607978720705, 11202.439878006067, 11204.047655949336, 11204.383758893176, 15090.24548772557, 16703.248353824107, 17402.651946961243, 17459.0, 17684.0, 4957.603391728725, 5789.2763404574425, 5925.288965324103, 6034.185384972972, 6238.282597501346, 864.8010957479814, 942.2838642631513, 975.5561219645044, 1043.2957753516346, 1116.0792346314324, 31343.37313253722, 32015.83992080025, 32036.35927281488, 32090.518642220384, 32800.0, 1016.7915577306634, 1042.968710938673, 1072.383379556758, 1074.5594306334365, 1132.9576789353814, 15316.617084572752, 16496.52389323941, 16501.83498165003, 16560.254788534305, 16961.49115526536, 441755.0, 446797.0, 448194.0, 448244.0, 449612.0, 42994.570054299686, 43660.0, 54811.72594137004, 56366.0, 56534.43465565292, 1284.5889315419163, 1324.708564115893, 1329.2157627000117, 1350.7568637645318, 1358.415881171086, 30172.628972512943, 32779.67220327766, 33133.33733325368, 33277.16807079843, 33436.498452523716, 45907.0, 46273.0, 46344.30483542817, 46364.536354636024, 46456.535434646576, 385454.0, 392917.0, 395634.0, 560090.0, 560709.0, 27338.45323093567, 27551.448971020065, 27663.308417288925, 27681.446371072867, 27725.72274277312, 46913.0, 47154.528454715015, 47196.0, 47258.0, 48006.0, 39821.0, 40219.597804021585, 41282.793586031876, 41547.37678934758, 43736.82095350536, 39271.80364098161, 39592.80203598963, 40056.0, 40596.59403405928, 40960.59039409568, 39561.80219098886, 40612.79693601513, 41210.79394603008, 42578.36132458078, 43149.56850431456, 30845.38309233758, 35105.154494873255, 35565.466518002766, 35943.0, 36488.27023459463, 26681.733182667926, 26847.726427951926, 26940.32649183786, 26954.865225673748, 27137.321566960196], "value": 19379.60730365155, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.95113659655937, 373.89530931339226, 375.8177284017251, 378.5381834162321, 395.5905637665017, 14147.504837330696, 18364.17361218745, 18869.245230190776, 19148.80851191488, 20447.0, 18580.814191858077, 19180.42458726237, 19222.0, 19346.51633709158, 19360.90319548404, 5269.2886460327845, 5520.475554822286, 5573.972130139364, 5578.776848926058, 5601.943980560183, 4057.5942405759333, 4266.0, 4304.612584867361, 5469.288992430998, 5498.615096943216, 6123.8162855114415, 6148.508119350464, 6299.275583307933, 6303.810885673437, 6314.968425157867, 6168.383161683818, 6222.239926703429, 6271.372862713738, 6284.497240220771, 6312.652804095773, 5534.972325138388, 5545.694986775726, 5548.167774833767, 5549.250851135126, 5551.639143455663, 22548.88725556362, 23244.65133023006, 23405.7659423407, 23431.297061088193, 23580.410489737722, 2224.12147201856, 2263.694401255826, 2280.065173278948, 2568.6018667106628, 3001.823677833575, 13437.731245375135, 14130.36413361391, 14389.64025899361, 14774.261286935718, 15066.623334416727, 1813.9727904081449, 1874.1378965675806, 1936.4868309897888, 1959.9706004409945, 1998.590288990768, 75643.62178189128, 76735.61632191803, 76789.61605191995, 79266.0, 79872.20127798706, 10108.342957707726, 10326.948365258126, 10327.483625818679, 10416.843747343795, 10627.787444251071, 14320.212388318743, 14351.282435878164, 14351.425942962165, 14354.354054067591, 14363.21002344881, 7298.489105762652, 7506.774796756106, 7573.545587264782, 7699.191584883619, 7725.729599463992, 7141.678624461912, 7177.138743350727, 7334.523255988343, 7354.485186036926, 7424.331810137113, 6150.907736383958, 6295.811125666146, 6302.905456418157, 6393.968030159819, 6461.935380646228, 1782.9554261143576, 1841.5856432302626, 1879.9342023029128, 1893.0, 1902.657521646117, 912.1289168843738, 994.8855881573712, 1014.3052009373603, 1030.299396410433, 1054.752133248686, 19142.8085719141, 20167.899160504396, 20247.39257822238, 20395.592088158155, 20516.281930132373, 977.1742877268839, 1023.5649848814373, 1035.3994683083945, 1038.2265212416798, 1058.3702696895334, 10498.265121441425, 10935.664106848015, 11064.502097405637, 11084.168687348481, 11308.434578271219, 392369.0, 409521.0, 422793.0, 427008.0, 429042.0, 75031.24968750242, 76430.6178469104, 77009.614951926, 77180.61409693028, 77790.22209777943, 1025.994870025645, 1042.374575254841, 1054.8997845204694, 1064.6060957445795, 1067.1516144664854, 16953.32186712567, 17134.571635709206, 17608.91195544014, 17762.644747105245, 18031.942812867, 37557.624423756504, 38669.41995870008, 38832.0, 39064.804675977575, 39168.804155979036, 50389.74805125951, 50661.493385065674, 51050.74474627603, 51206.487935120174, 52383.47616523786, 7643.847123057619, 8015.398845086758, 8074.555899425353, 8220.753377398449, 8466.365022623204, 12745.17156384832, 12868.935655321664, 12924.935375323063, 13155.0, 13297.601071967856, 11178.329300242012, 11370.260933039326, 11575.479103440533, 11682.357470339213, 12241.0, 11005.339679619248, 11032.834507482556, 11059.944700276768, 11221.158413119212, 11226.887731122584, 11199.160062995144, 11592.942035290107, 11786.351750653796, 11797.0, 11863.466144023367, 8237.31549472926, 8343.624536895975, 8438.257566290857, 8448.746537603882, 8604.655813767378, 11519.481623327138, 11582.305061696325, 11681.299122052704, 11700.941495292469, 11765.647030589096], "value": 9115.803197361785, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1268.56868664654, 1441.0705095213584, 1474.4102359056378, 1605.1813575076715, 1781.5189898727351, 7908.0, 8697.304215662747, 8960.686375976842, 9021.458712477248, 9283.535823208846, 8963.327750418712, 9043.773905652362, 9045.683401080963, 9047.45715257085, 9049.638014479413, 2211.712477377943, 2233.698450709158, 2234.4190510467315, 2235.307054813005, 2236.317923033474, 2125.426134943564, 2176.9891150544227, 2180.117052593694, 2195.8462907596477, 2221.044950671219, 2195.7145571075816, 2204.5370472200857, 2205.4817117977263, 2208.293346129239, 2248.685184074231, 2116.608427440928, 2124.1928067334393, 2128.8509804313703, 2136.337735302046, 2137.732783402075, 2118.936431907045, 2155.644318687415, 2156.277646988261, 2168.4362065862833, 2176.847620666554, 8443.282321002722, 8640.524771137585, 8785.692500762443, 8951.73144805657, 8971.506567138806, 5181.870453238662, 5315.6013299002725, 5324.148136298174, 5344.0, 5355.705436201008, 3230.628477725068, 3290.19390249388, 3313.155145437922, 3328.683775041367, 3382.30662714143, 1052.447465080831, 1077.6120596585224, 1098.6703988803326, 1101.3942331717603, 1133.2973556395004, 12677.936610316981, 12701.047421443336, 12732.936335318356, 12812.231266124156, 12815.743685126245, 4242.427272318259, 4391.538888416734, 4441.600255976978, 4514.119746649372, 4545.840895568639, 9922.206223502102, 9976.201903847676, 9995.100440960348, 10003.14973227284, 10012.299139060342, 5108.514691104339, 5109.821156259587, 5117.309163262987, 5135.38375394955, 5139.331886854685, 4031.4154447604933, 4203.138356636882, 4395.912081758411, 4742.170120228946, 4751.263554149044, 3364.8317584120696, 3704.499677630564, 3727.6086010968456, 3734.738568300247, 3755.3615885299564, 1066.3335415365398, 1101.1686176936362, 1109.9278546894427, 1110.7722916802036, 1115.642994241835, 901.0223907060912, 917.6283605139929, 929.2194556572512, 936.4007035497287, 950.9714708558754, 5824.271966004249, 5951.345352011275, 6144.815655530341, 6363.840903977345, 6397.4562162216735, 403.07896456596535, 409.6804492495858, 414.4570612497638, 422.06302009538774, 425.6254496043462, 3972.741771784825, 4141.503019637603, 4179.498460184797, 4205.558416366299, 4219.767912764827, 11025.44872756375, 11350.54597816078, 11388.886111138949, 11494.770104597861, 11501.769964600828, 11286.830697539543, 11294.60468883585, 11304.547818087349, 11342.829857552144, 11359.943200283946, 7940.444168908237, 8392.706255281037, 8449.0, 8463.74608761738, 8471.322294216448, 6232.252129744278, 6246.094316324198, 6405.103285539935, 6429.903551446826, 6499.350064993652, 10018.248631352824, 10495.21285903545, 10515.94742026285, 10603.992620701021, 10612.522436490222, 9639.421634701941, 10780.514876830719, 10906.945465272624, 10911.454427278763, 10937.45312734376, 7573.9242607573215, 7826.0, 7866.331361834079, 8005.07941586725, 8226.794330141794, 8255.545944972844, 8482.109378515168, 8628.22345988864, 8729.083446238054, 8860.512671803113, 7766.495177813424, 7981.640826162953, 8016.478928869605, 8027.678892844221, 8294.543800091053, 7850.097238817609, 7866.410019248465, 7951.602419879098, 7962.800929976565, 8055.919440805517, 7305.379042781211, 7321.6705248265025, 7381.409487241115, 7389.448215874511, 7390.3718183952815, 5102.3146261715165, 5205.906759580379, 5219.634625576173, 5318.920216196838, 5372.086745253395, 5179.093658609803, 5263.210518422267, 5369.785208591613, 5402.0, 5512.035393805988], "value": 4504.200162961665, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.7029477438595, 317.9189306726785, 327.6068717538954, 332.9550510681059, 334.89450822990773, 5225.477452254772, 5277.815276465324, 5297.523222909942, 5299.417064122943, 5338.306020217376, 5178.378594568648, 5211.609129315307, 5220.564344805181, 5283.260343551906, 5283.2867562879, 3856.2480316338324, 3955.821988010532, 4013.2174226025936, 4050.4936882889638, 4079.5920407959115, 4069.3752529618378, 4080.5919408059103, 4094.5086589609286, 4117.567655396185, 4119.217348703752, 4071.5521292657786, 4086.2644723949825, 4088.7342322748927, 4104.527979282391, 4105.117399759051, 3886.2810380079495, 3931.410288456726, 4049.5950404959417, 4059.3707975263883, 4088.713790034699, 3548.982255088708, 3555.2356243407535, 3560.3413368526903, 3580.1944562473495, 3585.229175727205, 5090.854557724482, 5093.541581257705, 5095.643304968654, 5101.591872650179, 5165.276861239429, 4443.37792709021, 4618.630509559261, 4642.489326174152, 4659.510751371091, 4682.859514214579, 5348.866278343034, 5413.971345444353, 5482.80810171642, 5485.451454854522, 5487.314085739283, 3903.8048097595292, 3904.8438062477467, 3926.9410958835642, 3936.724429289951, 3948.0, 5405.351357837046, 5547.694876781776, 5648.971755141239, 5684.578855286179, 5692.715364231772, 3890.2414029264587, 3891.2217556488818, 3897.162110146332, 3903.33643280643, 3904.6767173531703, 3932.6067393260446, 3958.663513601376, 3965.325894597925, 3975.92048159041, 3978.264021156095, 4494.955050449454, 4560.612347950395, 4616.469106052847, 4626.907461850811, 4638.1883170445035, 5477.808276710296, 5495.890082198333, 5504.284443022381, 5511.972440137773, 5514.448555144453, 1330.221820235154, 1348.4606157536869, 1350.5070649213162, 1352.452256835983, 1357.9864201358057, 815.9922495717784, 857.9613917373608, 869.1438932651333, 881.8677198420288, 890.9287257019423, 5083.313752643346, 5226.555742761908, 5249.110320284694, 5249.692693603082, 5253.185756207794, 5465.316835395575, 5511.255980442669, 5534.501894829485, 5642.097264437671, 5656.2929633795775, 5211.947880521222, 5329.626926115135, 5332.440093790174, 5332.453588459303, 5341.759620817073, 2918.8978385756395, 2971.257185703574, 2993.880244790184, 2995.9400811983637, 3016.7284944355115, 5771.220885180447, 5776.855578610484, 5806.564507661942, 5815.156802263648, 5848.678322692208, 5483.259759932438, 5665.3768085510565, 5703.971480142655, 5706.600537962386, 5712.22920894524, 5693.829185124453, 5752.683602401824, 5822.592418530747, 5840.737166827418, 5852.092925596539, 5424.1321388577635, 5649.54803615718, 5651.660900345993, 5663.969776169894, 5689.459501347365, 5583.525400341016, 5598.244237027949, 5637.0, 5638.7462564185535, 5641.802536911188, 5819.970900145641, 5826.621269617462, 5854.853628659318, 5903.527717782481, 5907.113932910098, 3728.3289007978824, 3928.135810121769, 3947.184295224229, 4033.5966403360603, 4041.8989525262105, 5612.765191657829, 5618.0, 5692.971535142297, 5710.0, 5713.514351280188, 5516.531094856982, 5529.640573362719, 5551.361593416647, 5590.5248053915875, 5593.720313984203, 5375.435579264277, 5409.7285697254465, 5481.890362192814, 5503.834884953458, 5510.724463776715, 5394.676319420847, 5430.13117901134, 5469.945300546943, 5472.452754724496, 5490.780368785364, 5382.784688612412, 5392.487713667196, 5507.256520369699, 5569.805056822992, 5581.832545023656, 5378.2739330189925, 5388.784448622011, 5390.541803946551, 5434.701091440009, 5456.127019676833], "value": 4160.666460517483, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.6127160697425, 741.0995640297039, 777.1606664802015, 779.7972527142945, 815.164456432157, 14324.856751432482, 15748.448804291853, 15757.369705211779, 15783.28975196116, 15790.921045394785, 14795.26023698816, 14921.552353429388, 14968.17675027873, 14971.25143742814, 14980.475683351086, 655.9475241980654, 672.559473544829, 795.7533164718956, 816.930560902324, 819.8237378963522, 786.8347646994138, 814.071957967917, 815.8816971539123, 817.0195765081896, 819.868820988639, 873.9475631462133, 875.8029443375221, 876.0494863073573, 876.1107475911955, 876.4171825735878, 876.0626130040858, 876.1545108969843, 876.2770714160811, 876.3514998900831, 877.4165180155189, 501.48801363887543, 522.1071966936543, 603.4749767702083, 629.0784001437916, 638.578538164809, 13917.52061984504, 13949.790753138712, 13953.720925581532, 13992.650183745487, 14013.0, 13120.86879131206, 13798.241096739675, 13813.171209727449, 13816.171029738147, 13931.233782141979, 12671.556495522706, 12965.321585727053, 13080.86919130806, 13135.211887286794, 13343.666408339772, 4139.482564679415, 4179.707420480568, 4180.122174343361, 4260.786960651986, 4321.675874309408, 76719.61640191819, 79757.60121199414, 81165.18834811635, 81243.59378203072, 81575.5921220396, 10106.494675266207, 10383.636572719919, 10432.113270371952, 10670.573177072985, 11150.553977840958, 20615.69076463854, 20638.452116091354, 20703.0, 20824.47938801542, 20831.791682083287, 7715.344195743424, 7969.880451793228, 8088.797780055545, 8208.753737387888, 8229.300509456643, 4428.092241090569, 4561.315802629566, 4649.642735118893, 4650.162970665245, 4659.487456379796, 3438.673326034023, 3551.236484155919, 3561.94657080144, 3567.108222944264, 3567.5897271813556, 619.7118339971935, 620.0667994667996, 622.9408206220402, 625.7309356976452, 645.470714014513, 532.6218384946653, 549.6682182826598, 556.0584507952965, 612.537534161714, 683.4256836743758, 8523.914760852436, 9611.855822162674, 9628.133467987775, 9660.792400949882, 9745.756356091013, 545.1332381513333, 645.7965740791635, 668.4151367553391, 668.9163854518185, 674.2179072276136, 4393.51671316155, 4616.053708989649, 4670.929936050894, 4673.3690951721765, 4743.501932297059, 66786.0, 70157.0, 112888.0, 120667.0, 123434.38282808529, 101544.49227753814, 101670.7326827704, 104194.0, 105130.47434762931, 107607.46196268969, 87291.0, 87653.56173219094, 88805.0, 88830.45204123552, 89408.5529572361, 8778.692745753868, 9141.817163656822, 9164.770880728036, 9219.953900230725, 9254.35219534653, 51334.229986549486, 52962.47037529575, 54038.45961540334, 54294.0, 54775.17837232365, 77878.6106069466, 78271.60864195642, 78964.21035789799, 79478.60260698659, 82858.0, 10619.94690026545, 10697.251192416456, 10751.569937202737, 11311.208215425171, 11921.34432606215, 12665.683357916127, 12736.363181840685, 13052.15161014531, 13200.14199077057, 13669.111507751964, 11768.411579420823, 12215.755684886075, 12270.32513211782, 12309.0, 12713.618591441902, 11581.536738530365, 13176.143550669176, 13278.734425311633, 13636.181829090287, 14299.356528956014, 13324.866751332362, 13499.122557033761, 13788.0, 14314.212718300178, 14350.0, 10359.84460233082, 10781.353118812896, 10978.890211097787, 11384.260023098803, 11398.430078495876, 11243.269187502787, 11485.19603627738, 11898.821517677416, 11998.460069296729, 12000.57997970067], "value": 7376.889713628034, "unit": "score"}], "name": "dromaeo_css", "value": 7082.16842027715, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 110.0, 111.0, 112.0, 110.0, 112.0, 109.0, 109.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 122.0, 122.0, 166.0, 123.0, 127.0, 120.0, 121.0, 149.0, 134.0], "value": 133.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 162.0, 163.0, 163.0, 162.0, 162.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 110.0, 75.0, 75.0, 75.0, 75.0, 98.0, 75.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 117.0, 82.0, 82.0, 83.0, 111.0, 82.0, 81.0, 106.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 145.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 51.0, 51.0, 52.0, 53.0, 52.0, 52.0, 52.0, 52.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 81.0, 80.0, 79.0, 89.0, 82.0, 79.0, 79.0, 80.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 145.0, 134.0, 133.0, 129.0, 133.0, 141.0, 132.0, 176.0, 131.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 171.0, 168.0, 170.0, 168.0, 167.0, 168.0, 169.0, 168.0, 170.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 68.0, 67.0, 66.0, 66.0, 65.0, 66.0, 71.0, 70.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1491.4999999999998, "alertThreshold": 2.0}]} 04:54:23 INFO - Return code: 0 04:54:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:54:23 INFO - # TBPL SUCCESS # 04:54:23 INFO - Running post-action listener: _resource_record_post_action 04:54:23 INFO - [mozharness: 2016-10-18 11:54:23.459220Z] Finished run-tests step (success) 04:54:23 INFO - Running post-run listener: _resource_record_post_run 04:54:23 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392192000; Read time: 12; Write time: 522060 04:54:23 INFO - TinderboxPrint: CPU usage
13.1% 04:54:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:54:23 INFO - TinderboxPrint: I/O write bytes / time
392,192,000 / 522,060 04:54:23 INFO - TinderboxPrint: CPU idle
8,322.8 (86.9%) 04:54:23 INFO - TinderboxPrint: CPU user
1,198.0 (12.5%) 04:54:23 INFO - TinderboxPrint: Swap in / out
0 / 0 04:54:23 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 103747584; Read time: 0; Write time: 211712 04:54:23 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288444416; Read time: 12; Write time: 310348 04:54:24 INFO - Running post-run listener: _upload_blobber_files 04:54:24 INFO - Blob upload gear active. 04:54:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:54:24 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 04:54:24 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:54:24 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:54:24 INFO - (blobuploader) - INFO - Open directory for files ... 04:54:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:54:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:54:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:25 INFO - (blobuploader) - INFO - Done attempting. 04:54:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:54:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:54:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:26 INFO - (blobuploader) - INFO - Done attempting. 04:54:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:54:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:54:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:29 INFO - (blobuploader) - INFO - Done attempting. 04:54:29 INFO - (blobuploader) - INFO - Iteration through files over. 04:54:29 INFO - Return code: 0 04:54:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:54:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:54:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e00a473ba997a9c1c5e0192fbac0b4fd005b22d82748fa2e6d69563786581f3d977b36da65b4d89df0f07fd70d3b1854805edd06c0e3be1206daebb71e15695", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/424f4fd9adec7777b10420fe6a80afdebe5cd0d0b36366710ee9f31ff21adeebaef07a1d9596b6b353cb6b09f8587c83ef94ac935f4e17676b4fd6323db585ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63e8fbf13f50a3afd430a3ec61de0e8b8e8dd8668eaef7f9b37b191bf64487706c4726880ad98e957009aaaf4fb089d952e42c46cfc2914d64aed2885bd33b9a"} 04:54:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:54:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:54:29 INFO - Contents: 04:54:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e00a473ba997a9c1c5e0192fbac0b4fd005b22d82748fa2e6d69563786581f3d977b36da65b4d89df0f07fd70d3b1854805edd06c0e3be1206daebb71e15695", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/424f4fd9adec7777b10420fe6a80afdebe5cd0d0b36366710ee9f31ff21adeebaef07a1d9596b6b353cb6b09f8587c83ef94ac935f4e17676b4fd6323db585ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63e8fbf13f50a3afd430a3ec61de0e8b8e8dd8668eaef7f9b37b191bf64487706c4726880ad98e957009aaaf4fb089d952e42c46cfc2914d64aed2885bd33b9a"} 04:54:29 INFO - Running post-run listener: copy_logs_to_upload_dir 04:54:29 INFO - Copying logs to upload dir... 04:54:29 INFO - mkdir: /builds/slave/test/build/upload/logs 04:54:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.234104 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-18 04:54:29.558221) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 04:54:29.562528) ========= 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=5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e00a473ba997a9c1c5e0192fbac0b4fd005b22d82748fa2e6d69563786581f3d977b36da65b4d89df0f07fd70d3b1854805edd06c0e3be1206daebb71e15695", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/424f4fd9adec7777b10420fe6a80afdebe5cd0d0b36366710ee9f31ff21adeebaef07a1d9596b6b353cb6b09f8587c83ef94ac935f4e17676b4fd6323db585ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63e8fbf13f50a3afd430a3ec61de0e8b8e8dd8668eaef7f9b37b191bf64487706c4726880ad98e957009aaaf4fb089d952e42c46cfc2914d64aed2885bd33b9a"} build_url:https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011235 build_url: 'https://queue.taskcluster.net/v1/task/XTcAhpHhQVqrhtqdgD3D2g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e00a473ba997a9c1c5e0192fbac0b4fd005b22d82748fa2e6d69563786581f3d977b36da65b4d89df0f07fd70d3b1854805edd06c0e3be1206daebb71e15695", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/424f4fd9adec7777b10420fe6a80afdebe5cd0d0b36366710ee9f31ff21adeebaef07a1d9596b6b353cb6b09f8587c83ef94ac935f4e17676b4fd6323db585ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63e8fbf13f50a3afd430a3ec61de0e8b8e8dd8668eaef7f9b37b191bf64487706c4726880ad98e957009aaaf4fb089d952e42c46cfc2914d64aed2885bd33b9a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 04:54:29.589095) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:54:29.589452) ========= 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=5cf47e208febbcd81da23b2e0000026f-1476790392.689885-1688468686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:54:29.674544) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 04:54:29.674880) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 04:54:29.675219) ========= ========= Total master_lag: 0.18 =========