builder: cedar_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-043 starttime: 1477663121.97 results: success (0) buildid: 20161028053259 builduid: 34a76bebcc3d498ca0edef668f19a97d revision: 7da7c94c891aa23072d956dc93cef59c345b160a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 06:58:41.966488) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 06:58:41.967497) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 06:58:41.968213) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 06:58:41.983970) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 06:58:41.984266) ========= 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=d2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-28 06:58:42-- 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.2M=0s 2016-10-28 06:58:42 (62.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118540 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 06:58:42.116625) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 06:58:42.117069) ========= 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=d2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013962 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 06:58:42.169983) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-28 06:58:42.170640) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 7da7c94c891aa23072d956dc93cef59c345b160a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 7da7c94c891aa23072d956dc93cef59c345b160a --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=d2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-28 06:58:42,567 truncating revision to first 12 chars 2016-10-28 06:58:42,567 Setting DEBUG logging. 2016-10-28 06:58:42,567 attempt 1/10 2016-10-28 06:58:42,567 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/7da7c94c891a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-28 06:58:43,939 unpacking tar archive at: cedar-7da7c94c891a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.684217 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-28 06:58:43.872408) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 06:58:43.873161) ========= script_repo_revision: 7da7c94c891aa23072d956dc93cef59c345b160a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 06:58:43.874010) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 06:58:43.874643) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 06:58:43.885831) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-28 06:58:43.886530) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] 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=d2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:58:44 INFO - MultiFileLogger online at 20161028 06:58:44 in /builds/slave/test 06:58:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 06:58:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:58:44 INFO - {'append_to_log': False, 06:58:44 INFO - 'base_work_dir': '/builds/slave/test', 06:58:44 INFO - 'blob_upload_branch': 'Cedar', 06:58:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:58:44 INFO - 'branch': 'Cedar', 06:58:44 INFO - 'buildbot_json_path': 'buildprops.json', 06:58:44 INFO - 'config_files': ('talos/linux_config.py',), 06:58:44 INFO - 'default_actions': ('clobber', 06:58:44 INFO - 'read-buildbot-config', 06:58:44 INFO - 'download-and-extract', 06:58:44 INFO - 'populate-webroot', 06:58:44 INFO - 'create-virtualenv', 06:58:44 INFO - 'install', 06:58:44 INFO - 'run-tests'), 06:58:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:58:44 INFO - 'download_minidump_stackwalk': True, 06:58:44 INFO - 'download_symbols': 'ondemand', 06:58:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:58:44 INFO - 'tooltool.py': '/tools/tooltool.py', 06:58:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:58:44 INFO - '/tools/misc-python/virtualenv.py')}, 06:58:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:58:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:58:44 INFO - 'installer_path': 'installer.exe', 06:58:44 INFO - 'log_level': 'info', 06:58:44 INFO - 'log_name': 'talos', 06:58:44 INFO - 'log_to_console': True, 06:58:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:58:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:58:44 INFO - 'opt_config_files': (), 06:58:44 INFO - 'pip_index': False, 06:58:44 INFO - 'sps_profile': False, 06:58:44 INFO - 'sps_profile_interval': 0, 06:58:44 INFO - 'suite': 'dromaeojs', 06:58:44 INFO - 'system_bits': '32', 06:58:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:58:44 INFO - 'title': 'talos-linux64-ix-043', 06:58:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:58:44 INFO - 'use_talos_json': True, 06:58:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:58:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:58:44 INFO - 'work_dir': 'build'} 06:58:44 INFO - [mozharness: 2016-10-28 13:58:44.385520Z] Running clobber step. 06:58:44 INFO - Running pre-action listener: _resource_record_pre_action 06:58:44 INFO - Running main action method: clobber 06:58:44 INFO - rmtree: /builds/slave/test/build 06:58:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:58:45 INFO - Running post-action listener: _resource_record_post_action 06:58:45 INFO - [mozharness: 2016-10-28 13:58:45.367421Z] Finished clobber step (success) 06:58:45 INFO - [mozharness: 2016-10-28 13:58:45.367527Z] Running read-buildbot-config step. 06:58:45 INFO - Running pre-action listener: _resource_record_pre_action 06:58:45 INFO - Running main action method: read_buildbot_config 06:58:45 INFO - Using buildbot properties: 06:58:45 INFO - { 06:58:45 INFO - "project": "", 06:58:45 INFO - "product": "firefox", 06:58:45 INFO - "script_repo_revision": "default", 06:58:45 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs", 06:58:45 INFO - "repository": "", 06:58:45 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs", 06:58:45 INFO - "buildid": "20161028053259", 06:58:45 INFO - "pgo_build": "False", 06:58:45 INFO - "basedir": "/builds/slave/test", 06:58:45 INFO - "buildnumber": 1, 06:58:45 INFO - "slavename": "talos-linux64-ix-043", 06:58:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:58:45 INFO - "platform": "ubuntu64_hw", 06:58:45 INFO - "scheduler": "tests-cedar-linux64-talos", 06:58:45 INFO - "branch": "cedar", 06:58:45 INFO - "repo_path": "projects/cedar", 06:58:45 INFO - "revision": "7da7c94c891aa23072d956dc93cef59c345b160a", 06:58:45 INFO - "stage_platform": "linux64", 06:58:45 INFO - "builduid": "34a76bebcc3d498ca0edef668f19a97d", 06:58:45 INFO - "slavebuilddir": "test" 06:58:45 INFO - } 06:58:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:58:45 INFO - Running post-action listener: _resource_record_post_action 06:58:45 INFO - [mozharness: 2016-10-28 13:58:45.369950Z] Finished read-buildbot-config step (success) 06:58:45 INFO - [mozharness: 2016-10-28 13:58:45.370039Z] Running download-and-extract step. 06:58:45 INFO - Running pre-action listener: _resource_record_pre_action 06:58:45 INFO - Running main action method: download_and_extract 06:58:45 INFO - mkdir: /builds/slave/test/build/tests 06:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:45 INFO - trying https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:58:45 INFO - Downloading https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:58:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:58:45 INFO - Downloaded 1361 bytes. 06:58:45 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:58:45 INFO - Using the following test package requirements: 06:58:45 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:58:45 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:58:45 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:58:45 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:45 INFO - u'jsshell-linux-x86_64.zip'], 06:58:45 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:58:45 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:58:45 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:58:45 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:58:45 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:58:45 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:58:45 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:58:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:58:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:58:45 INFO - Fetch https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:58:46 INFO - Http code: 200 06:58:46 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 06:58:46 INFO - x-amz-cf-id: hVFcUTZinEPgtgZbtREGrV9J5mEdRBPkiNAjSYv2DIbPj-tSMDp2mQ== 06:58:46 INFO - x-amz-version-id: uC5A8gd5MO1rO0tHhOyS2LD870mG6KjL 06:58:46 INFO - Expected file size: 20424473 06:58:46 INFO - Obtained file size: 20424473 06:58:50 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:58:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:58:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:58:50 INFO - Fetch https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:58:51 INFO - Http code: 200 06:58:51 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 06:58:51 INFO - x-amz-cf-id: m_UO87OhFR-vH3kKtjuNSf2mIBSOy2lIqoiLfYp7LqxYhZXROh8Ihg== 06:58:51 INFO - x-amz-version-id: uC5A8gd5MO1rO0tHhOyS2LD870mG6KjL 06:58:51 INFO - Expected file size: 20424473 06:58:51 INFO - Obtained file size: 20424473 06:58:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:58:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:58:56 INFO - Fetch https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:58:56 INFO - Http code: 200 06:58:56 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 06:58:56 INFO - x-amz-cf-id: G1viykUeW1Ng1kgkpZOkrVJ1IKCfWqCTZnJS7Q4PEXTVl07EKn7FmA== 06:58:56 INFO - x-amz-version-id: RdPhPHwmFA7fkKDnfRhGobGqCLiR_nCr 06:58:56 INFO - Expected file size: 14409028 06:58:56 INFO - Obtained file size: 14409028 06:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:57 INFO - trying https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:58:57 INFO - Downloading https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:58:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:58:58 INFO - Downloaded 55482481 bytes. 06:58:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:58:58 INFO - mkdir: /builds/slave/test/properties 06:58:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:58:58 INFO - Writing to file /builds/slave/test/properties/build_url 06:58:58 INFO - Contents: 06:58:58 INFO - build_url:https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:58:59 INFO - Running post-action listener: _resource_record_post_action 06:58:59 INFO - Running post-action listener: set_extra_try_arguments 06:58:59 INFO - [mozharness: 2016-10-28 13:58:59.081666Z] Finished download-and-extract step (success) 06:58:59 INFO - [mozharness: 2016-10-28 13:58:59.081965Z] Running populate-webroot step. 06:58:59 INFO - Running pre-action listener: _resource_record_pre_action 06:58:59 INFO - Running main action method: populate_webroot 06:58:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:58:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:58:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:58:59 INFO - '--tppagecycles', 06:58:59 INFO - '7'], 06:58:59 INFO - 'tests': ['tsvgm']}}, 06:58:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:58:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:58:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:58:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:58:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:58:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:58:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:59 INFO - 'talos_options': ['--disable-e10s'], 06:58:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:59 INFO - 'talos_options': ['--disable-e10s'], 06:58:59 INFO - 'tests': ['damp', 'tps']}, 06:58:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:59 INFO - 'tests': ['damp', 'tps']}, 06:58:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:58:59 INFO - 'tests': ['dromaeo_dom']}, 06:58:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:58:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:58:59 INFO - 'tests': ['basic_compositor_video']}, 06:58:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:58:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:58:59 INFO - 'tests': ['a11yr', 06:58:59 INFO - 'ts_paint', 06:58:59 INFO - 'tpaint', 06:58:59 INFO - 'sessionrestore', 06:58:59 INFO - 'sessionrestore_no_auto_restore', 06:58:59 INFO - 'tabpaint']}, 06:58:59 INFO - 'other-e10s': {'tests': ['a11yr', 06:58:59 INFO - 'ts_paint', 06:58:59 INFO - 'tpaint', 06:58:59 INFO - 'sessionrestore', 06:58:59 INFO - 'sessionrestore_no_auto_restore', 06:58:59 INFO - 'tabpaint']}, 06:58:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:58:59 INFO - 'ts_paint', 06:58:59 INFO - 'tpaint', 06:58:59 INFO - 'sessionrestore', 06:58:59 INFO - 'sessionrestore_no_auto_restore', 06:58:59 INFO - 'tabpaint']}, 06:58:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:58:59 INFO - 'ts_paint', 06:58:59 INFO - 'tpaint', 06:58:59 INFO - 'sessionrestore', 06:58:59 INFO - 'sessionrestore_no_auto_restore', 06:58:59 INFO - 'tabpaint']}, 06:58:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:58:59 INFO - 'tests': ['a11yr', 06:58:59 INFO - 'ts_paint', 06:58:59 INFO - 'tpaint', 06:58:59 INFO - 'sessionrestore', 06:58:59 INFO - 'sessionrestore_no_auto_restore', 06:58:59 INFO - 'tabpaint']}, 06:58:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:58:59 INFO - 'tests': ['a11yr', 06:58:59 INFO - 'ts_paint', 06:58:59 INFO - 'tpaint', 06:58:59 INFO - 'sessionrestore', 06:58:59 INFO - 'sessionrestore_no_auto_restore', 06:58:59 INFO - 'tabpaint']}, 06:58:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:58:59 INFO - 'tests': ['tsvgx', 06:58:59 INFO - 'tsvgr_opacity', 06:58:59 INFO - 'tart', 06:58:59 INFO - 'tscrollx', 06:58:59 INFO - 'cart']}, 06:58:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:58:59 INFO - 'tsvgr_opacity', 06:58:59 INFO - 'tart', 06:58:59 INFO - 'tscrollx', 06:58:59 INFO - 'cart']}, 06:58:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:59 INFO - 'talos_options': ['--disable-e10s'], 06:58:59 INFO - 'tests': ['tp5o']}, 06:58:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:59 INFO - 'tests': ['tp5o']}, 06:58:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:59 INFO - 'talos_options': ['--disable-e10s', 06:58:59 INFO - '--xperf_path', 06:58:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:59 INFO - 'tests': ['tp5n']}, 06:58:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:59 INFO - 'talos_options': ['--xperf_path', 06:58:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:59 INFO - 'tests': ['tp5n']}}, 06:58:59 INFO - 'talos.zip': {'path': '', 06:58:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:58:59 INFO - Running post-action listener: _resource_record_post_action 06:58:59 INFO - [mozharness: 2016-10-28 13:58:59.102640Z] Finished populate-webroot step (success) 06:58:59 INFO - [mozharness: 2016-10-28 13:58:59.102732Z] Running create-virtualenv step. 06:58:59 INFO - Running pre-action listener: _resource_record_pre_action 06:58:59 INFO - Running main action method: create_virtualenv 06:58:59 INFO - Creating virtualenv /builds/slave/test/build/venv 06:58:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:58:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:58:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:58:59 INFO - Using real prefix '/usr' 06:58:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:58:59 INFO - Installing distribute.............................................................................................................................................................................................done. 06:59:01 INFO - Installing pip.................done. 06:59:01 INFO - Return code: 0 06:59:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:59:01 INFO - Reading from file tmpfile_stdout 06:59:01 INFO - Output received: 06:59:01 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:59:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:01 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 0x7fe8b2802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd25790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd22930>, '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 0xd23830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd23cc0>, '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': 'd2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:59:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:59:01 INFO - Using env: {'DISPLAY': ':0', 06:59:01 INFO - 'HOME': '/home/cltbld', 06:59:01 INFO - 'LANG': 'en_US.UTF-8', 06:59:01 INFO - 'LANGUAGE': 'en_US:en', 06:59:01 INFO - 'LOGNAME': 'cltbld', 06:59:01 INFO - 'MAIL': '/var/mail/cltbld', 06:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:01 INFO - 'MOZ_NO_REMOTE': '1', 06:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:01 INFO - 'NO_EM_RESTART': '1', 06:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:01 INFO - 'PWD': '/builds/slave/test', 06:59:01 INFO - 'SHELL': '/bin/bash', 06:59:01 INFO - 'SHLVL': '1', 06:59:01 INFO - 'TERM': 'linux', 06:59:01 INFO - 'TMOUT': '86400', 06:59:01 INFO - 'USER': 'cltbld', 06:59:01 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383', 06:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:01 INFO - '_': '/tools/buildbot/bin/python'} 06:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:59:02 INFO - Cleaning up... 06:59:02 INFO - Return code: 0 06:59:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:02 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 0x7fe8b2802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd25790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd22930>, '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 0xd23830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd23cc0>, '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': 'd2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:59:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:59:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:59:02 INFO - Using env: {'DISPLAY': ':0', 06:59:02 INFO - 'HOME': '/home/cltbld', 06:59:02 INFO - 'LANG': 'en_US.UTF-8', 06:59:02 INFO - 'LANGUAGE': 'en_US:en', 06:59:02 INFO - 'LOGNAME': 'cltbld', 06:59:02 INFO - 'MAIL': '/var/mail/cltbld', 06:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:02 INFO - 'MOZ_NO_REMOTE': '1', 06:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:02 INFO - 'NO_EM_RESTART': '1', 06:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:02 INFO - 'PWD': '/builds/slave/test', 06:59:02 INFO - 'SHELL': '/bin/bash', 06:59:02 INFO - 'SHLVL': '1', 06:59:02 INFO - 'TERM': 'linux', 06:59:02 INFO - 'TMOUT': '86400', 06:59:02 INFO - 'USER': 'cltbld', 06:59:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383', 06:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:02 INFO - '_': '/tools/buildbot/bin/python'} 06:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:02 INFO - Downloading/unpacking psutil>=3.1.1 06:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:59:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:59:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:59:04 INFO - Installing collected packages: psutil 06:59:04 INFO - Running setup.py install for psutil 06:59:04 INFO - building 'psutil._psutil_linux' extension 06:59:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:59:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:59:04 INFO - building 'psutil._psutil_posix' extension 06:59:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:59:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:59:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:59:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:59:04 INFO - Successfully installed psutil 06:59:04 INFO - Cleaning up... 06:59:04 INFO - Return code: 0 06:59:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:04 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 0x7fe8b2802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd25790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd22930>, '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 0xd23830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd23cc0>, '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': 'd2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:59:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:59:04 INFO - Using env: {'DISPLAY': ':0', 06:59:04 INFO - 'HOME': '/home/cltbld', 06:59:04 INFO - 'LANG': 'en_US.UTF-8', 06:59:04 INFO - 'LANGUAGE': 'en_US:en', 06:59:04 INFO - 'LOGNAME': 'cltbld', 06:59:04 INFO - 'MAIL': '/var/mail/cltbld', 06:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:04 INFO - 'MOZ_NO_REMOTE': '1', 06:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:04 INFO - 'NO_EM_RESTART': '1', 06:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:04 INFO - 'PWD': '/builds/slave/test', 06:59:04 INFO - 'SHELL': '/bin/bash', 06:59:04 INFO - 'SHLVL': '1', 06:59:04 INFO - 'TERM': 'linux', 06:59:04 INFO - 'TMOUT': '86400', 06:59:04 INFO - 'USER': 'cltbld', 06:59:04 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383', 06:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:04 INFO - '_': '/tools/buildbot/bin/python'} 06:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:59:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:59:07 INFO - Installing collected packages: mozsystemmonitor 06:59:07 INFO - Running setup.py install for mozsystemmonitor 06:59:07 INFO - Successfully installed mozsystemmonitor 06:59:07 INFO - Cleaning up... 06:59:07 INFO - Return code: 0 06:59:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:07 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 0x7fe8b2802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd25790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd22930>, '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 0xd23830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd23cc0>, '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': 'd2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:59:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:59:07 INFO - Using env: {'DISPLAY': ':0', 06:59:07 INFO - 'HOME': '/home/cltbld', 06:59:07 INFO - 'LANG': 'en_US.UTF-8', 06:59:07 INFO - 'LANGUAGE': 'en_US:en', 06:59:07 INFO - 'LOGNAME': 'cltbld', 06:59:07 INFO - 'MAIL': '/var/mail/cltbld', 06:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:07 INFO - 'MOZ_NO_REMOTE': '1', 06:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:07 INFO - 'NO_EM_RESTART': '1', 06:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:07 INFO - 'PWD': '/builds/slave/test', 06:59:07 INFO - 'SHELL': '/bin/bash', 06:59:07 INFO - 'SHLVL': '1', 06:59:07 INFO - 'TERM': 'linux', 06:59:07 INFO - 'TMOUT': '86400', 06:59:07 INFO - 'USER': 'cltbld', 06:59:07 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383', 06:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:07 INFO - '_': '/tools/buildbot/bin/python'} 06:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:07 INFO - Downloading/unpacking jsonschema==2.5.1 06:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:59:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:59: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 06:59: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 06:59: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 06:59: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 06:59: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 06:59: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 06:59:09 INFO - Downloading functools32-3.2.3-2.tar.gz 06:59:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:59:09 INFO - warning: no files found matching '*.txt' 06:59:09 INFO - no previously-included directories found matching 'build' 06:59:09 INFO - no previously-included directories found matching 'dist' 06:59:09 INFO - no previously-included directories found matching '.git*' 06:59:09 INFO - Installing collected packages: jsonschema, functools32 06:59:09 INFO - Running setup.py install for functools32 06:59:09 INFO - warning: no files found matching '*.txt' 06:59:09 INFO - no previously-included directories found matching 'build' 06:59:09 INFO - no previously-included directories found matching 'dist' 06:59:09 INFO - no previously-included directories found matching '.git*' 06:59:09 INFO - Successfully installed jsonschema functools32 06:59:09 INFO - Cleaning up... 06:59:09 INFO - Return code: 0 06:59:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:59: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')]} 06:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59: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')]} 06:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59: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', '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 0x7fe8b2802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd25790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd22930>, '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 0xd23830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd23cc0>, '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': 'd2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:59: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:59: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 functools32==3.2.3-2 06:59:09 INFO - Using env: {'DISPLAY': ':0', 06:59:09 INFO - 'HOME': '/home/cltbld', 06:59:09 INFO - 'LANG': 'en_US.UTF-8', 06:59:09 INFO - 'LANGUAGE': 'en_US:en', 06:59:09 INFO - 'LOGNAME': 'cltbld', 06:59:09 INFO - 'MAIL': '/var/mail/cltbld', 06:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:09 INFO - 'MOZ_NO_REMOTE': '1', 06:59:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:09 INFO - 'NO_EM_RESTART': '1', 06:59:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:09 INFO - 'PWD': '/builds/slave/test', 06:59:09 INFO - 'SHELL': '/bin/bash', 06:59:09 INFO - 'SHLVL': '1', 06:59:09 INFO - 'TERM': 'linux', 06:59:09 INFO - 'TMOUT': '86400', 06:59:09 INFO - 'USER': 'cltbld', 06:59:09 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383', 06:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:09 INFO - '_': '/tools/buildbot/bin/python'} 06:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:59:10 INFO - Cleaning up... 06:59:10 INFO - Return code: 0 06:59:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe8b2802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd25790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd22930>, '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 0xd23830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd23cc0>, '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': 'd2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:59:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:59:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:59:10 INFO - Using env: {'DISPLAY': ':0', 06:59:10 INFO - 'HOME': '/home/cltbld', 06:59:10 INFO - 'LANG': 'en_US.UTF-8', 06:59:10 INFO - 'LANGUAGE': 'en_US:en', 06:59:10 INFO - 'LOGNAME': 'cltbld', 06:59:10 INFO - 'MAIL': '/var/mail/cltbld', 06:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:10 INFO - 'MOZ_NO_REMOTE': '1', 06:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:10 INFO - 'NO_EM_RESTART': '1', 06:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:10 INFO - 'PWD': '/builds/slave/test', 06:59:10 INFO - 'SHELL': '/bin/bash', 06:59:10 INFO - 'SHLVL': '1', 06:59:10 INFO - 'TERM': 'linux', 06:59:10 INFO - 'TMOUT': '86400', 06:59:10 INFO - 'USER': 'cltbld', 06:59:10 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383', 06:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:10 INFO - '_': '/tools/buildbot/bin/python'} 06:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:10 INFO - Downloading/unpacking blobuploader==1.2.4 06:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:12 INFO - Downloading blobuploader-1.2.4.tar.gz 06:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:59:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:59: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 06:59: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 06:59: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 06:59: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 06:59: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 06:59: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 06:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:59:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:59: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 06:59: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 06:59: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 06:59: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 06:59: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 06:59: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 06:59:12 INFO - Downloading docopt-0.6.1.tar.gz 06:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:59:13 INFO - Installing collected packages: blobuploader, requests, docopt 06:59:13 INFO - Running setup.py install for blobuploader 06:59:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:59:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:59:13 INFO - Running setup.py install for requests 06:59:13 INFO - Running setup.py install for docopt 06:59:13 INFO - Successfully installed blobuploader requests docopt 06:59:13 INFO - Cleaning up... 06:59:13 INFO - Return code: 0 06:59:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:13 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 0x7fe8b2802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd25790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd22930>, '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 0xd23830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd23cc0>, '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': 'd2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:59:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:59:13 INFO - Using env: {'DISPLAY': ':0', 06:59:13 INFO - 'HOME': '/home/cltbld', 06:59:13 INFO - 'LANG': 'en_US.UTF-8', 06:59:13 INFO - 'LANGUAGE': 'en_US:en', 06:59:13 INFO - 'LOGNAME': 'cltbld', 06:59:13 INFO - 'MAIL': '/var/mail/cltbld', 06:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:13 INFO - 'MOZ_NO_REMOTE': '1', 06:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:13 INFO - 'NO_EM_RESTART': '1', 06:59:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:13 INFO - 'PWD': '/builds/slave/test', 06:59:13 INFO - 'SHELL': '/bin/bash', 06:59:13 INFO - 'SHLVL': '1', 06:59:13 INFO - 'TERM': 'linux', 06:59:13 INFO - 'TMOUT': '86400', 06:59:13 INFO - 'USER': 'cltbld', 06:59:13 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383', 06:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:13 INFO - '_': '/tools/buildbot/bin/python'} 06:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:59:13 INFO - Running setup.py (path:/tmp/pip-OW2YWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:59:13 INFO - Running setup.py (path:/tmp/pip-h4e_A1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:59:14 INFO - Running setup.py (path:/tmp/pip-xjT1nY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:59:14 INFO - Running setup.py (path:/tmp/pip-3UCeyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:59:14 INFO - Running setup.py (path:/tmp/pip-xByFWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:59:14 INFO - Running setup.py (path:/tmp/pip-rz9Udh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:59:14 INFO - Running setup.py (path:/tmp/pip-0OuVIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:59:14 INFO - Running setup.py (path:/tmp/pip-6V7uWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:59:14 INFO - Running setup.py (path:/tmp/pip-wKlgfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:59:14 INFO - Running setup.py (path:/tmp/pip-aID6G1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:59:14 INFO - Running setup.py (path:/tmp/pip-gOVs5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:59:14 INFO - Running setup.py (path:/tmp/pip-DSPBil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:59:14 INFO - Running setup.py (path:/tmp/pip-AdvkIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:59:14 INFO - Running setup.py (path:/tmp/pip-gimYgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:14 INFO - Running setup.py (path:/tmp/pip-zAuPac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:59:14 INFO - Running setup.py (path:/tmp/pip-MsTd4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:59:15 INFO - Running setup.py (path:/tmp/pip-hPUSF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:59:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:59:15 INFO - Running setup.py install for manifestparser 06:59:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:59:15 INFO - Running setup.py install for mozcrash 06:59:15 INFO - Running setup.py install for mozdebug 06:59:15 INFO - Running setup.py install for mozdevice 06:59:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:59:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:59:15 INFO - Running setup.py install for mozfile 06:59:15 INFO - Running setup.py install for mozhttpd 06:59:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:59:15 INFO - Running setup.py install for mozinfo 06:59:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:59:15 INFO - Running setup.py install for mozInstall 06:59:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:59:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:59:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:59:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:59:15 INFO - Running setup.py install for mozleak 06:59:15 INFO - Running setup.py install for mozlog 06:59:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:59:16 INFO - Running setup.py install for moznetwork 06:59:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:59:16 INFO - Running setup.py install for mozprocess 06:59:16 INFO - Running setup.py install for mozprofile 06:59:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:59:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:59:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:59:16 INFO - Running setup.py install for mozrunner 06:59:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:59:16 INFO - Running setup.py install for mozscreenshot 06:59:16 INFO - Running setup.py install for moztest 06:59:16 INFO - Running setup.py install for mozversion 06:59:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:59:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:59:16 INFO - Cleaning up... 06:59:16 INFO - Return code: 0 06:59:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:16 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 0x7fe8b2802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd25790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd22930>, '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 0xd23830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd23cc0>, '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': 'd2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:59:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:59:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:59:16 INFO - Using env: {'DISPLAY': ':0', 06:59:16 INFO - 'HOME': '/home/cltbld', 06:59:16 INFO - 'LANG': 'en_US.UTF-8', 06:59:16 INFO - 'LANGUAGE': 'en_US:en', 06:59:16 INFO - 'LOGNAME': 'cltbld', 06:59:16 INFO - 'MAIL': '/var/mail/cltbld', 06:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:16 INFO - 'MOZ_NO_REMOTE': '1', 06:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:16 INFO - 'NO_EM_RESTART': '1', 06:59:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:16 INFO - 'PWD': '/builds/slave/test', 06:59:16 INFO - 'SHELL': '/bin/bash', 06:59:16 INFO - 'SHLVL': '1', 06:59:16 INFO - 'TERM': 'linux', 06:59:16 INFO - 'TMOUT': '86400', 06:59:16 INFO - 'USER': 'cltbld', 06:59:16 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383', 06:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:16 INFO - '_': '/tools/buildbot/bin/python'} 06:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:59:17 INFO - Running setup.py (path:/tmp/pip-OJZdST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:59:17 INFO - Running setup.py (path:/tmp/pip-AvLaEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:59:17 INFO - Running setup.py (path:/tmp/pip-J36dhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:59:17 INFO - Running setup.py (path:/tmp/pip-ZXqrFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:59:17 INFO - Running setup.py (path:/tmp/pip-7EFGG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:59:17 INFO - Running setup.py (path:/tmp/pip-RRunG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:59:17 INFO - Running setup.py (path:/tmp/pip-2Nd0tV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:59:17 INFO - Running setup.py (path:/tmp/pip-Wy4zeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:59:17 INFO - Running setup.py (path:/tmp/pip-TdB9bI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:59:17 INFO - Running setup.py (path:/tmp/pip-6ZIkbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:59:17 INFO - Running setup.py (path:/tmp/pip-r6VsVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:59:17 INFO - Running setup.py (path:/tmp/pip-P4IJVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:59:18 INFO - Running setup.py (path:/tmp/pip-Fnhzgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:59:18 INFO - Running setup.py (path:/tmp/pip-iA_GYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:18 INFO - Running setup.py (path:/tmp/pip-WusPTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:59:18 INFO - Running setup.py (path:/tmp/pip-SZo9P0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:59:18 INFO - Running setup.py (path:/tmp/pip-BgzDSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:59:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:20 INFO - Downloading blessings-1.6.tar.gz 06:59:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:59:20 INFO - Installing collected packages: blessings 06:59:20 INFO - Running setup.py install for blessings 06:59:20 INFO - Successfully installed blessings 06:59:20 INFO - Cleaning up... 06:59:20 INFO - Return code: 0 06:59:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:59:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:59:20 INFO - Reading from file tmpfile_stdout 06:59:20 INFO - Current package versions: 06:59:20 INFO - argparse == 1.2.1 06:59:20 INFO - blessings == 1.6 06:59:20 INFO - blobuploader == 1.2.4 06:59:20 INFO - docopt == 0.6.1 06:59:20 INFO - functools32 == 3.2.3-2 06:59:20 INFO - jsonschema == 2.5.1 06:59:20 INFO - manifestparser == 1.1 06:59:20 INFO - mozInstall == 1.12 06:59:20 INFO - mozcrash == 0.17 06:59:20 INFO - mozdebug == 0.1 06:59:20 INFO - mozdevice == 0.48 06:59:20 INFO - mozfile == 1.2 06:59:20 INFO - mozhttpd == 0.7 06:59:20 INFO - mozinfo == 0.9 06:59:20 INFO - mozleak == 0.1 06:59:20 INFO - mozlog == 3.4 06:59:20 INFO - moznetwork == 0.27 06:59:20 INFO - mozprocess == 0.23 06:59:20 INFO - mozprofile == 0.28 06:59:20 INFO - mozrunner == 6.12 06:59:20 INFO - mozscreenshot == 0.1 06:59:20 INFO - mozsystemmonitor == 0.3 06:59:20 INFO - moztest == 0.7 06:59:20 INFO - mozversion == 1.4 06:59:20 INFO - psutil == 3.1.1 06:59:20 INFO - requests == 1.2.3 06:59:20 INFO - wsgiref == 0.1.2 06:59:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:20 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 0x7fe8b2802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd25790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd22930>, '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 0xd23830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd23cc0>, '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': 'd2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:59:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:59:20 INFO - Using env: {'DISPLAY': ':0', 06:59:20 INFO - 'HOME': '/home/cltbld', 06:59:20 INFO - 'LANG': 'en_US.UTF-8', 06:59:20 INFO - 'LANGUAGE': 'en_US:en', 06:59:20 INFO - 'LOGNAME': 'cltbld', 06:59:20 INFO - 'MAIL': '/var/mail/cltbld', 06:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:20 INFO - 'MOZ_NO_REMOTE': '1', 06:59:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:20 INFO - 'NO_EM_RESTART': '1', 06:59:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:20 INFO - 'PWD': '/builds/slave/test', 06:59:20 INFO - 'SHELL': '/bin/bash', 06:59:20 INFO - 'SHLVL': '1', 06:59:20 INFO - 'TERM': 'linux', 06:59:20 INFO - 'TMOUT': '86400', 06:59:20 INFO - 'USER': 'cltbld', 06:59:20 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383', 06:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:20 INFO - '_': '/tools/buildbot/bin/python'} 06:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:59:21 INFO - Cleaning up... 06:59:21 INFO - Return code: 0 06:59:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8b2802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd25790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd22930>, '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 0xd23830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd23cc0>, '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': 'd2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:59:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:59:21 INFO - Using env: {'DISPLAY': ':0', 06:59:21 INFO - 'HOME': '/home/cltbld', 06:59:21 INFO - 'LANG': 'en_US.UTF-8', 06:59:21 INFO - 'LANGUAGE': 'en_US:en', 06:59:21 INFO - 'LOGNAME': 'cltbld', 06:59:21 INFO - 'MAIL': '/var/mail/cltbld', 06:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:21 INFO - 'MOZ_NO_REMOTE': '1', 06:59:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:21 INFO - 'NO_EM_RESTART': '1', 06:59:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:21 INFO - 'PWD': '/builds/slave/test', 06:59:21 INFO - 'SHELL': '/bin/bash', 06:59:21 INFO - 'SHLVL': '1', 06:59:21 INFO - 'TERM': 'linux', 06:59:21 INFO - 'TMOUT': '86400', 06:59:21 INFO - 'USER': 'cltbld', 06:59:21 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383', 06:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:21 INFO - '_': '/tools/buildbot/bin/python'} 06:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:59:21 INFO - Cleaning up... 06:59:21 INFO - Return code: 0 06:59:21 INFO - Running post-action listener: _resource_record_post_action 06:59:21 INFO - Running post-action listener: _start_resource_monitoring 06:59:21 INFO - Starting resource monitoring. 06:59:21 INFO - [mozharness: 2016-10-28 13:59:21.285183Z] Finished create-virtualenv step (success) 06:59:21 INFO - [mozharness: 2016-10-28 13:59:21.285650Z] Running install step. 06:59:21 INFO - Running pre-action listener: _resource_record_pre_action 06:59:21 INFO - Running main action method: install 06:59:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:59:21 INFO - Reading from file tmpfile_stdout 06:59:21 INFO - Detecting whether we're running mozinstall >=1.0... 06:59:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:59:21 INFO - Reading from file tmpfile_stdout 06:59:21 INFO - Output received: 06:59:21 INFO - Usage: mozinstall [options] installer 06:59:21 INFO - Options: 06:59:21 INFO - -h, --help show this help message and exit 06:59:21 INFO - -d DEST, --destination=DEST 06:59:21 INFO - Directory to install application into. [default: 06:59:21 INFO - "/builds/slave/test"] 06:59:21 INFO - --app=APP Application being installed. [default: firefox] 06:59:21 INFO - mkdir: /builds/slave/test/build/application 06:59:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:59:37 INFO - Reading from file tmpfile_stdout 06:59:37 INFO - Output received: 06:59:37 INFO - /builds/slave/test/build/application/firefox/firefox 06:59:37 INFO - Running post-action listener: _resource_record_post_action 06:59:37 INFO - [mozharness: 2016-10-28 13:59:37.588860Z] Finished install step (success) 06:59:37 INFO - [mozharness: 2016-10-28 13:59:37.589104Z] Running run-tests step. 06:59:37 INFO - Running pre-action listener: _resource_record_pre_action 06:59:37 INFO - Running main action method: run_tests 06:59:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:59:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:59:37 INFO - Python 2.7.3 06:59:37 INFO - Return code: 0 06:59:37 INFO - grabbing minidump binary from tooltool 06:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:37 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 0xd22930>, '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 0xd23830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd23cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:59:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:59:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:59:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:59:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:59:37 INFO - Return code: 0 06:59:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:59:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:59:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:59:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:59:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:59:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:59:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:59:37 INFO - Using env: {'DISPLAY': ':0', 06:59:37 INFO - 'HOME': '/home/cltbld', 06:59:37 INFO - 'LANG': 'en_US.UTF-8', 06:59:37 INFO - 'LANGUAGE': 'en_US:en', 06:59:37 INFO - 'LOGNAME': 'cltbld', 06:59:37 INFO - 'MAIL': '/var/mail/cltbld', 06:59:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:59:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:37 INFO - 'MOZ_NO_REMOTE': '1', 06:59:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:59:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:37 INFO - 'NO_EM_RESTART': '1', 06:59:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:37 INFO - 'PWD': '/builds/slave/test', 06:59:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:59:37 INFO - 'SHELL': '/bin/bash', 06:59:37 INFO - 'SHLVL': '1', 06:59:37 INFO - 'TERM': 'linux', 06:59:37 INFO - 'TMOUT': '86400', 06:59:37 INFO - 'USER': 'cltbld', 06:59:37 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383', 06:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:37 INFO - '_': '/tools/buildbot/bin/python'} 06:59:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:59:37 INFO - mozversion application_buildid: 20161028053259 06:59:37 INFO - mozversion application_changeset: 7da7c94c891aa23072d956dc93cef59c345b160a 06:59:37 INFO - mozversion application_display_name: Nightly 06:59:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:59:37 INFO - mozversion application_name: Firefox 06:59:37 INFO - mozversion application_remotingname: firefox 06:59:37 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 06:59:37 INFO - mozversion application_vendor: Mozilla 06:59:37 INFO - mozversion application_version: 52.0a1 06:59:37 INFO - mozversion platform_buildid: 20161028053259 06:59:37 INFO - mozversion platform_changeset: 7da7c94c891aa23072d956dc93cef59c345b160a 06:59:37 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 06:59:37 INFO - mozversion platform_version: 52.0a1 06:59:37 INFO - using testdate: 1477663177 06:59:37 INFO - actual date: 1477663177 06:59:37 INFO - starting webserver on 'localhost:59697' 06:59:37 INFO - SUITE-START | Running 2 tests 06:59:37 INFO - TEST-START | dromaeo_css 06:59:37 INFO - operating with platform_type : linux_ 06:59:37 INFO - Initialising browser for dromaeo_css test... 06:59:37 INFO - TEST-INFO | started process 9854 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprwo162/profile http://localhost:59697/getInfo.html) 06:59:42 INFO - PROCESS | 9854 | __metrics Screen width/height:1600/1200 06:59:42 INFO - PROCESS | 9854 | colorDepth:24 06:59:42 INFO - PROCESS | 9854 | Browser inner width/height: 1024/697 06:59:42 INFO - PROCESS | 9854 | __metrics 06:59:43 INFO - PROCESS | 9854 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:59:43 INFO - PROCESS | 9854 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:59:44 INFO - PROCESS | 9854 | console.error: PushService: 06:59:44 INFO - PROCESS | 9854 | stateChangeProcessEnqueue: Error transitioning state 06:59:44 INFO - PROCESS | 9854 | UnknownError 06:59:44 INFO - TEST-INFO | 9854: exit 0 06:59:44 INFO - Browser initialized. 06:59:44 INFO - Running cycle 1/1 for dromaeo_css test... 06:59:44 INFO - TEST-INFO | started process 9936 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprwo162/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:59:57 INFO - PROCESS | 9936 | RSS: Main: 173727744 06:59:57 INFO - PROCESS | 9936 | 07:00:47 INFO - PROCESS | 9936 | 1477663247948 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] 07:03:02 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:59697/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59697/tests/dromaeo/cssquery-ext.html) 07:03:03 INFO - PROCESS | 9936 | RSS: Main: 277037056 07:03:03 INFO - PROCESS | 9936 | 07:06:06 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:59697/tests/dromaeo/cssquery-ext.html (next: http://localhost:59697/tests/dromaeo/cssquery-jquery.html) 07:06:06 INFO - PROCESS | 9936 | RSS: Main: 280420352 07:06:06 INFO - PROCESS | 9936 | 07:09:09 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:59697/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59697/tests/dromaeo/cssquery-mootools.html) 07:09:09 INFO - PROCESS | 9936 | RSS: Main: 249352192 07:09:09 INFO - PROCESS | 9936 | 07:12:12 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:59697/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59697/tests/dromaeo/cssquery-prototype.html) 07:12:12 INFO - PROCESS | 9936 | RSS: Main: 218492928 07:12:12 INFO - PROCESS | 9936 | 07:15:15 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:59697/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59697/tests/dromaeo/cssquery-yui.html) 07:15:16 INFO - PROCESS | 9936 | RSS: Main: 219025408 07:15:16 INFO - PROCESS | 9936 | 07:18:19 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:59697/tests/dromaeo/cssquery-yui.html (next: http://localhost:59697/tests/dromaeo/cssquery-dojo.html) 07:18:19 INFO - PROCESS | 9936 | RSS: Main: 309604352 07:18:19 INFO - PROCESS | 9936 | 07:18:19 INFO - PROCESS | 9936 | __start_tp_report 07:18:19 INFO - PROCESS | 9936 | _x_x_mozilla_page_load 07:18:19 INFO - PROCESS | 9936 | _x_x_mozilla_page_load_details 07:18:19 INFO - PROCESS | 9936 | |i|pagename|runs| 07:18:19 INFO - PROCESS | 9936 | |0;dojo.html;2509.7615726505983;2545.618157276409;2557.8081643876712;2563.4104156044123;2573.819832611718;4463;4486.461624605044;4530.207213737599;4546.272596384575;4560.247559152735;4574.83988060418;4625.352450656911;4676.97661511692;4705.882352941178;4748.667593268473;4152.252594532983;4177.937330940038;4219.641330486897;4246.087091275375;4247.469066366704;4254.340577210522;4322.675799315049;4357.063231405247;4363.80362883671;4412.492563355223;4156.937645935283;4273.7008409411355;4279.251131052053;4285.292926667096;4378.6934914555995;4206.158768246332;4261.339492378686;4270.487541495009;4274.209271284792;4277.550857159985;4162.250794856925;4251.893702657459;4256.723312984646;4258.53156152823;4272.316429371285;4546.0680560485025;4555.544445555418;4560.179167749804;4606.884827879297;4625.745583992879;4841.951580484185;4847.733374664392;4853.563179313879;4854.951450485485;4917.582005529534;4832.516748325139;4878.780454879539;4881.51184881509;4895.437024742165;4940.28365886948;4549.7042692224895;4605.032943081923;4616.630669546428;4619.076184762994;4681.438227412664;5030.924536131961;5033.144365457881;5034.622403319766;5040.54635082837;5093.210552364315;4781.306710527024;4824.059308434892;4828.275758636162;4833.73414462208;4885.658003939761;4727.621790256771;4782.0914026334885;4788.4253889533475;4885.6335774817035;4912.72979986097;4883.34074899891;4900.803967841318;4943.110240156734;4958.9008219835405;4962.851114466572;4880.243562247857;4888.706677599284;4888.902221955612;4894.902101957941;4950.356453661001;3759.71802114837;3805.2199299144163;3808.4858544096746;3937.5078115235597;3946.6053394660303;3390.4914262860766;3416.3850506908993;3426.1605906553054;3428.074419906611;3476.878309259164;4173.874783756492;4175.582441755861;4179.623833854967;4220.535741068541;4227;4751.928721069186;4826.058918510927;4833.3958255218095;4839.758012099381;4895.412550493892;4146.440230568895;4155.625993660585;4202.075543380452;4203.810828512663;4206.831726730958;4385.451818522684;4422.889427764268;4428.601425871622;4431.357453169272;4431.357453169337;4529.8641040768825;4547.090581883636;4554.2257816172;4555.567221113989;4566.45202575693;4851.830185943475;4937.382827146606;4946.134426475281;4946.925796113133;4947.82682606107;4558.749268790249;4561.315802629632;4566.840160594364;4569.565891240327;4626.629869610356;4790.377250957354;4805.903881922272;4808.783604737865;4816.8795780105775;4821.252705830602;4781.115493633689;4797.928031079607;4831.855044348676;4866.951330486791;4868.245421959602;4711;4716.1510928033285;4717.457492388419;4751.786169622306;4774.618030557616;4727.834525791581;4732.171869922819;4737.976310118427;4783.904321913612;4789.736564488987;4598.333241680005;4644.0944015916575;4660.86017419478;4662.5104364042645;4663.044075964352;4756.381670382828;4795.256735206049;4797.280407938837;4838.2016967201425;4859.31969524274;4689.859304220879;4700.788464519173;4701.717896926195;4763.1426343258545;4763.16644587189 07:18:19 INFO - PROCESS | 9936 | |1;ext.html;544.78481000005;549.2776998247305;552.4861878453039;561.9297587801525;562.4768964862677;38732.41901371478;40450.595494045054;40484.59515404849;43704;44342.33486497705;39829.402558961636;40433.7978310108;40458;40537.391939120935;40597.39103913444;7630.7710768677025;7763.534187948713;7764.922350776505;7772.4947878388;7773.883391749128;7754.185810489902;7826.72606458774;7830.29527342539;7831.138574756772;7833.569153696544;7820.960895195516;7830.021247344082;7853.489523181003;7858.410619203554;7864.449488535776;7738.806529836743;7780.844383112306;7782.494137881048;7824.21757824213;7836.725714600018;7669.501482403626;7741.419393545507;7744.303012728825;7744.41916856238;7781.572013539253;37783.433248501016;38320.80839595812;38321.42517862234;38350.80824595887;38396.42405363922;2973.3458639099363;2974.375381169957;2987.507061334877;3128.3117714103087;3297.653746356622;28156.296092597644;28184.577231341547;28303.433931321466;28494.927557790157;28716.13851584456;3045.725884670368;3067.371188906269;3103.5965324507897;3161.0674850919036;3199.1027028100057;240135;241128;242858.7857060721;243595;244079;44613.33080003803;44875.551244487135;44890.55109448929;44959.55040449554;44963.55036449594;31541.36917261688;32316.35367292641;32524.512132318036;34276.828615856764;52514.47485525172;14892.851071489147;15071.321790519452;15073.698526029419;15094.622634434007;15095.245237738069;11317.547298107984;11453.427328633536;11457.427128643534;11457.656270311738;11460;17936.372226972253;17992.370267040853;18025.459236222934;18101.366452174112;18152.183151758203;6634.734610615618;6662.800115996528;6780.491463140284;6808.114945057111;7092.716291348392;702.3923064695613;801.9879701804477;811.7443005453264;825.5748289630845;837.4640230252643;26639.600405993926;26672.59991100135;26826.15502747352;26974.32564185872;27397.863010684818;712.4834494991194;897.4480694373044;949.852772820214;963.6482683820495;971.5433746139303;13818.723625527433;13876.306184690726;14202.715945681235;14270.429182832779;14474.421023158955;362008;364980;365692;366068;366121;48856;49235.50764492381;49235.75382123067;49340.50659493431;49377.75311123421;986.9309148359689;1000.049952545085;1037.4760745823462;1075.725689949058;1088.216484131424;25143.74856251414;27374.863125684245;28415.715842842135;28752.85623571869;29202.269943251587;46250.53749462462;46846.53153468558;46902.53097469118;46936.29595556001;46980.29529556991;355137.2431378369;358067;358376;358783;359088;24060.87969560141;24548.263552093467;24918.37704057413;25885.741142588333;37524.249515009;41003.12978091624;41302.38046429366;41397;41694.374584380654;41935.370969436095;34844.65155348516;35557.28885422329;35649.643503564635;35901.461478078374;36020.09949751277;35002.64997349994;35071.47392789059;35232.29535409329;35427;35555.822220889764;33246.83376583102;33931.4910276351;34108.82945585256;34946.47580286247;35442.291154177285;30071.69928300689;31920.6807931927;32143;32365;32521.674783251863;24713.752862471145;24721.72646419914;24811.751882480945;24897;25114.748852511973 07:18:19 INFO - PROCESS | 9936 | |2;jquery.html;343.8074678180218;358.6288191721567;368.7676763638908;373.30565148823194;383.2488322887141;12423.503059877594;12736.681582960431;12932.094753367257;13122.081454298203;16315.428959986402;16123.677526449494;16289.104099274535;16320.83679163208;16374.426895058676;16400.67198656026;4645.88385290367;4702.717836929795;4790.688605240665;4832.106060378841;4867.123917694814;4718.504557021515;4804.183288840905;4808.2547205183255;4809.302651115586;4810.206315957863;3897.9610203898023;4772.451168115659;4790.041991601676;4791.377120974268;4792.664513484057;4731.739754313511;4763.190257656207;4766.713997160182;4770.332153498478;4771.212749896263;4202.558731333196;4254.074922069744;4300.333448315516;4303.462067241595;4303.784810759449;18379.63240735178;18672.813271867242;19054.237830486763;19449.90275048616;19466;1841.1990784008865;1868.504846215754;1883.4726276642562;2081.552466219755;2449.816263780224;11777.705557361134;12365;12418.503259869685;12840.807387889188;13031.413586388635;1655.4867990922853;1684.2420910590283;1751.3870145449118;1772.397384889131;1772.9911350443294;61212;63458;63806;65008.99999999953;65130.67434662844;8925.464472131693;9195.77010574741;9198.080191980882;9333.353321240687;9369.48467834262;12835.48658053686;12846.357682116044;12848.678783030498;12849.357532123357;12861.549845755353;6436.388543088399;6638.800835974928;6710.127683401224;6726.529142960044;6875.896861547081;6187.412195841388;6283.5287353448675;6459.870802583922;6460.483161347081;6503.626176445563;5766.365699773021;5841.503472204825;5877.794277200363;5937.168796368512;6104.450599445982;1682.3186609423203;1712.914354282281;1729.325563030419;1730.0830559803323;1749.6238308763677;781.5193655901579;826.01703972274;827.210014436212;849.3757088539918;934.7569631895756;15789.68420631581;16510.17449127539;16606.50180494587;16794.916025419796;17014.48956531306;755.8586534333197;791.4538968112099;812.5937031484258;837.9664813407518;862.6118246788844;8840.734777956543;9300.162985331353;9633.277504187214;9807.117359437685;9913.900860991442;275905;281953;282447;359546;370695;55364;67799.32200678029;68566.314336856;70844.64577677182;74843;887.5296093070683;892.3352102683542;914.5198770645331;929.3587424676952;932.2262522106771;11019.889801101886;14134.929325353307;15043.398264069314;15185.6203594911;15397.384104635688;34609.65390346065;34717.652823472454;34744.13139671528;35729;36728;44596.55403446054;44676.55323446724;45099.323510146714;46042.539574605165;47692;6762.289959554176;6942.361902477026;6984.546004509691;7378.741744038933;7388.593627350548;9019.143181397756;10595.735106622396;11365.715857103307;11545.595904143314;11721.179517433698;9553.140217380469;9741.074597913186;9923.057309555581;9978.501074946369;10205.965556603482;9541.761455963657;9984.550695218877;10029.398236105857;10202.234832387749;10221.131203847755;9712.854307185256;9794.65718699842;10116.443595602312;10209.591616335263;10594.788104238027;7401;7547.433942454228;7711.498752581064;7800.258975397328;7998.760037198894;8535;9278.211352035152;9666.806663866542;9960.103590676874;10239.84640230412 07:18:19 INFO - PROCESS | 9936 | |3;mootools.html;1244.5706231350186;1327.8804907558317;1330.029078772496;1630.779363121189;1680.55465301695;6247.18786557748;6458.160439142916;6575;6927.618980956046;6930.5841649501;6766.560173588713;7071.469639777025;7075.85848283034;7242.456815738814;7260.23767504411;2053.4968932611496;2078.490769761411;2082.739657542807;2088.98955505223;2090.7282053333047;1776.2450958342718;1839.264294282291;2044.509317763741;2084.3642688979853;2097.769245383007;1962.57804572017;2040.6632905570564;2045.1819272291054;2056.7017782421613;2064.6077245323418;2054.352878843167;2056.393363957636;2090.843186760999;2101.7162683037745;2106.5786842631383;2077.8233850122756;2131.1475409836034;2132.744070711509;2135.487483004068;2137.358792362285;7227.638618069075;7286.890696639554;7288.708451661927;7289.015982842355;7289.38040266578;4080.7143499955014;4202.978985105055;4222.852200172979;4420.381146639473;4421.646268298528;2635.420207554335;2720.8911643534234;2816.450792095542;2818.5631227159824;2828.3777568935006;881.1364862434785;886.7428445750725;888.5335199020501;891.8528442806929;906.4515967839494;9354.859677104849;9388.765280867965;9397.060293970617;9409.29430292724;9409.858852117224;3630.2013557017412;3863.150106976461;3907.902302442462;3926.980365098156;4027.677785777131;8254.504729716236;8259.95870020658;8280.792980175424;8280.83438331242;8281.751547453587;4429.778511074498;4431.7562534060935;4433.911321773547;4434.113177364476;4434.689571729948;3810.580836108026;4051.1290072634524;4053.8783836484954;4058.857939972087;4059.4925634295714;3288.309455014426;3358.7816791908936;3428.6057103433423;3438.020164253176;3529.400001999666;992.5979978108877;1022.9130523905551;1101.0640955188026;1113.5323164271026;1124.4321617583068;711.2851584157888;734.1483878700682;779.734890137356;790.7864876483317;818.083746204255;4698.577128058491;4768.070226305837;4775.856724298276;4851.320815085891;4853.12643724126;781.7967328494518;816.7876352148484;835.2232423845882;836.3142223376773;840.8318336332758;3146.2606287522412;3278.852451639634;3307.503874418808;3321.485169798685;3384.0693809202176;7949.920500795034;8063.717769878143;8215.465994710445;8307.543085130255;8636.093210212837;8505.659773608986;8509.319254459751;8513.95743021281;8526.87209691855;8533.738559281795;6498.252700939358;6593.703283352261;6675.432588229958;6735.932640673628;6736.2590115087305;4963;5041.143005689115;5073.898522029465;5092.0579692756955;5162.741862906914;7415.258474152542;7636.885446718193;7642.770716878503;7737.3036426721865;7884.1327453978865;7880.566568838769;7980.201979801974;8017.759467215993;8037.718679846177;8041.959790201246;6132.601380910227;6308.684565771601;6308.936910631019;6310.810675679737;6312.242530896322;6755.4257888080065;6768.593884366756;6807.3873351398615;6809.38715515606;6817.659117044227;6173.783917562864;6174.722137503913;6185.505159587312;6191.81424557264;6227.377262273736;6070.605410648293;6086.452219300284;6123.540734444845;6132;6177.938220617916;5509.614326997072;5521.309836270466;5560.833175004756;5561.888762224652;5565.638233514808;4192.9161416770885;4215.768132752728;4249.107687385684;4294.377315289203;4342.196693611692;4304.6556275498515;4348.978255108705;4364.912701745884;4366.847160349373;4373.825046998211 07:18:19 INFO - PROCESS | 9936 | |4;prototype.html;293.5919072489239;294.7479904681497;298.2841181165204;306.6871790773413;309.92097015261106;4830.492798256185;4851.81130622997;4866.24573191155;4882.902341953163;4886.804527818883;4778.3549220855175;4784.880377990552;4825.686330388522;4871.220604703248;4872.70763754175;3818.854343696894;3819.6631179087235;3820.9808950955207;3831.61683831616;3836.251930873481;3713.758605690635;3802.4106263529197;3837.635424634669;3849.5957924417953;3851.28751181031;3713.275911197318;3740.214554943465;3744.120131769032;3744.326021316162;3753.662170404663;3711.183539621279;3714.591394946554;3720.5907350191455;3737.121776382548;3740.1584643455276;3158.5735925649974;3246.4156451838658;3247.610286765603;3285.227971426713;3294.8187849668257;4645.512221216791;4659.138059458977;4672.649551283667;4679.508651591568;4696.483386827446;4295.248331541968;4298.828046878121;4306.8277268909205;4306.849260275875;4308.3968244445805;4673.836415725434;4796.3524924135145;4994.875128121826;5004.749762511859;5039.697618142924;3575.928481430357;3579.6062433132333;3592;3606.801625910574;3612.1330880588735;5177.275181474596;5199;5199.558037566773;5202.583793296527;5224.164133738622;3580.2839432113683;3672.1186915140706;3686.870959516458;3691.187938653492;3694.131879008431;3697.4453831925425;3723.72072094594;3725.2735716535017;3749.9250015000093;3757.380032294641;4231.746095234295;4241.915161696748;4262.168877069003;4272.316429371285;4298.474041715209;5036.823711170092;5039.319691841554;5041.218611115283;5052.736815796051;5056.342675452168;1279.2388528825334;1312.566852938528;1327.82074419954;1327.9867201327863;1332.8467226269104;808.2160304504739;850.5917159763349;858.9434994956239;862.7886167888907;864.4165188497739;3950.740638972859;3952.2095580883365;3959.8416063357718;3964.4053391990856;3964.841406343714;4487.349334346502;4532.388127602798;4534.841280555164;4544.886377840514;4567.451905771329;3947.763134211899;3950.2297052075146;3957.9604203957592;3960.485136932238;3965.405189221582;2272.4547307830835;2444.6455263986622;2457.6436416719475;2465.6794616699713;2470.505898820207;4315.4605674290715;4625.468071171791;4647.814087436533;4784.808607655725;4810.11012962603;5217.50433708797;5221.947780522222;5260.34352651916;5271.446498117719;5293.682379057269;4800.359802108896;4801.399825021872;4802.135615589227;4806.567408933212;4855.36880205571;4965.751712414437;5111.948880511296;5124.256982737556;5128.923066153936;5186.170212765939;4979.701217926936;4998.300237966615;5004.949950500449;5014.674046186986;5026.47222041695;4840.782164802663;4840.854774356775;4848.151573474698;4850.95149048505;4852.296417019583;3455.274392377629;3660.2679464106754;3669.853205871735;3676.6507181817683;3683.318586061587;5201.557867581147;5206.687598744087;5216.139337009503;5223.9477605223465;5264.89470210586;5027.949720502748;5073.416557095981;5076.18780995039;5097.6941383517105;5108.66793658411;4943.703377797344;4971.9502804972935;5011.699298041984;5024.6231532634465;5055.418626857959;4924.72913989734;4928.162212423825;4929.975350123226;4932.383452068491;4942.6293028023765;5039.21892106724;5041.6470847040355;5044.394672639307;5049.318342023927;5055.443901170795;4757.405324334458;4980.477049909708;5013.248012797963;5015.724135172454;5021.246812978083 07:18:19 INFO - PROCESS | 9936 | |5;yui.html;609.6159419565674;661.7683810666267;713.1192976673807;731.8646050480664;740.844422671239;11970.700732481693;12889.162204456727;12893;12922.09545331826;12960.15758975666;12230.51077956883;12348.4443200056;12356.938215308934;12369.752604947897;12373.381330933462;616.1650962945212;636.8121404185753;731.1153504259826;776.2509178642608;784.1531146361915;785.5208322923041;788.1763557082862;789.3211837819471;789.3685051958411;789.3842802613971;647.1748520636179;843.2916350265775;846.0397448895517;846.1158089796178;847.3560094328324;670.5641333133453;821.8520666280098;842.9536375499345;843.9451435656663;852.2031900173296;612.9264488261438;613.4846728747873;614.6987975891781;616.873540924114;616.929053158888;12700.364981750876;12718.618441446772;12726.490940362375;12753.936230318881;12756.744865102739;12948.611541653765;12958;13071.346432678329;13255.867441325656;13298.135621184592;10039.74900627483;10076.798464030679;10222.131118854906;10281.126104281146;10333.948330258301;3305.768596198267;3308.17295676081;3348.631650518441;3363.6636336366414;3364.5457863188403;46427.535724643;46807.76596117032;48059.519404805855;48095.278570821465;48168;8367.707130250412;8604.268637165911;8742.475451472932;8901.421407608485;8960.68637597681;15799.289031993589;15946.362145514282;15954.04275743436;15975.520734377988;16090.195490225442;6250;6301.6219026858535;6419.51853610981;6579.111819904348;6598.208215014229;3495.9300813983577;3542.6103128655827;3562.1985053363305;3601.081724160375;3622.5471816022996;2597.1039991203006;2681.410089780245;2685.9731402685725;2694.514987302265;2695.8517281549703;467.6632824366451;508.37723788358966;522.5662699959025;530.1279395394554;540.1088204462668;485.87367284506286;555.2559570175903;591.2520661363379;593.483669207792;596.2457491273542;6974.721011159599;7283.927160728431;7478.588677622674;7771.455998080193;7808.141104478503;581.8632621333983;592.1384385718769;603.7434090511603;607.7052629474701;614.3334482086897;3592.856285748541;3651.72612054097;3685.94471082934;3692.2615476904725;3763.6989040876665;65365;69885.65057174783;70189.29810701827;70651.3478921685;72764.27235727682;59826;63808.68095659492;65270.347296527376;65651.67174164098;65978;56232.718836405555;56679;57458.712706437036;57885.421145788845;58042.12936805951;7076.433885289061;7111.745306317815;7253.347198752138;7437.735584950679;7558.962205188939;33611.49582756212;34818;35913;36245.27509449849;37177.4423383644;47521.52478475171;49712.29459433794;50069.74965125151;50258.497415025384;50600.49399505958;9234.630614775333;9540.95229523848;9595;9610;9614.855777163208;10469.424181670081;10483.737906552396;10660.375472339441;10796.406197659204;10902.454877256265;9469.573869176042;9642.276829237975;9703.563339649592;10055.145312648214;10481;10151.340162889388;10466.267361284637;10559.328805433664;10593;10616.044555989998;10249.641262555775;10375.16998640122;10405.583776649151;10427.374357538572;10550.683479495627;8942.37403381757;9137.725868223964;9234.26125909939;9511.809763804824;9649.951750241204;8947.552622368985;9551.188149007412;9574.856377154209;9602.327837051618;9664.613415463584 07:18:19 INFO - PROCESS | 9936 | __end_tp_report 07:18:19 INFO - PROCESS | 9936 | __start_cc_report 07:18:19 INFO - PROCESS | 9936 | _x_x_mozilla_cycle_collect,1228 07:18:19 INFO - PROCESS | 9936 | __end_cc_report 07:18:19 INFO - PROCESS | 9936 | __startTimestamp1477664299297__endTimestamp 07:18:19 INFO - PROCESS | 9936 | 07:18:19 INFO - PROCESS | 9936 | ------- Summary: start ------- 07:18:19 INFO - PROCESS | 9936 | Number of tests: 6 07:18:19 INFO - PROCESS | 9936 | 07:18:19 INFO - PROCESS | 9936 | [#0] dojo.html Cycles:165 Average:4508.83 Median:4644.09 stddev:490.02 (10.6%) stddev-sans-first:465.75 07:18:19 INFO - PROCESS | 9936 | Values: 2509.8 2545.6 2557.8 2563.4 2573.8 4463.0 4486.5 4530.2 4546.3 4560.2 4574.8 4625.4 4677.0 4705.9 4748.7 4152.3 4177.9 4219.6 4246.1 4247.5 4254.3 4322.7 4357.1 4363.8 4412.5 4156.9 4273.7 4279.3 4285.3 4378.7 4206.2 4261.3 4270.5 4274.2 4277.6 4162.3 4251.9 4256.7 4258.5 4272.3 4546.1 4555.5 4560.2 4606.9 4625.7 4842.0 4847.7 4853.6 4855.0 4917.6 4832.5 4878.8 4881.5 4895.4 4940.3 4549.7 4605.0 4616.6 4619.1 4681.4 5030.9 5033.1 5034.6 5040.5 5093.2 4781.3 4824.1 4828.3 4833.7 4885.7 4727.6 4782.1 4788.4 4885.6 4912.7 4883.3 4900.8 4943.1 4958.9 4962.9 4880.2 4888.7 4888.9 4894.9 4950.4 3759.7 3805.2 3808.5 3937.5 3946.6 3390.5 3416.4 3426.2 3428.1 3476.9 4173.9 4175.6 4179.6 4220.5 4227.0 4751.9 4826.1 4833.4 4839.8 4895.4 4146.4 4155.6 4202.1 4203.8 4206.8 4385.5 4422.9 4428.6 4431.4 4431.4 4529.9 4547.1 4554.2 4555.6 4566.5 4851.8 4937.4 4946.1 4946.9 4947.8 4558.7 4561.3 4566.8 4569.6 4626.6 4790.4 4805.9 4808.8 4816.9 4821.3 4781.1 4797.9 4831.9 4867.0 4868.2 4711.0 4716.2 4717.5 4751.8 4774.6 4727.8 4732.2 4738.0 4783.9 4789.7 4598.3 4644.1 4660.9 4662.5 4663.0 4756.4 4795.3 4797.3 4838.2 4859.3 4689.9 4700.8 4701.7 4763.1 4763.2 07:18:19 INFO - PROCESS | 9936 | 07:18:19 INFO - PROCESS | 9936 | [#1] ext.html Cycles:180 Average:46957.05 Median:197554.05 stddev:86016.68 (43.5%) stddev-sans-first:86187.40 07:18:19 INFO - PROCESS | 9936 | Values: 544.8 549.3 552.5 561.9 562.5 38732.4 40450.6 40484.6 43704.0 44342.3 39829.4 40433.8 40458.0 40537.4 40597.4 7630.8 7763.5 7764.9 7772.5 7773.9 7754.2 7826.7 7830.3 7831.1 7833.6 7821.0 7830.0 7853.5 7858.4 7864.4 7738.8 7780.8 7782.5 7824.2 7836.7 7669.5 7741.4 7744.3 7744.4 7781.6 37783.4 38320.8 38321.4 38350.8 38396.4 2973.3 2974.4 2987.5 3128.3 3297.7 28156.3 28184.6 28303.4 28494.9 28716.1 3045.7 3067.4 3103.6 3161.1 3199.1 240135.0 241128.0 242858.8 243595.0 244079.0 44613.3 44875.6 44890.6 44959.6 44963.6 31541.4 32316.4 32524.5 34276.8 52514.5 14892.9 15071.3 15073.7 15094.6 15095.2 11317.5 11453.4 11457.4 11457.7 11460.0 17936.4 17992.4 18025.5 18101.4 18152.2 6634.7 6662.8 6780.5 6808.1 7092.7 702.4 802.0 811.7 825.6 837.5 26639.6 26672.6 26826.2 26974.3 27397.9 712.5 897.4 949.9 963.6 971.5 13818.7 13876.3 14202.7 14270.4 14474.4 362008.0 364980.0 365692.0 366068.0 366121.0 48856.0 49235.5 49235.8 49340.5 49377.8 986.9 1000.0 1037.5 1075.7 1088.2 25143.7 27374.9 28415.7 28752.9 29202.3 46250.5 46846.5 46902.5 46936.3 46980.3 355137.2 358067.0 358376.0 358783.0 359088.0 24060.9 24548.3 24918.4 25885.7 37524.2 41003.1 41302.4 41397.0 41694.4 41935.4 34844.7 35557.3 35649.6 35901.5 36020.1 35002.6 35071.5 35232.3 35427.0 35555.8 33246.8 33931.5 34108.8 34946.5 35442.3 30071.7 31920.7 32143.0 32365.0 32521.7 24713.8 24721.7 24811.8 24897.0 25114.7 07:18:19 INFO - PROCESS | 9936 | 07:18:19 INFO - PROCESS | 9936 | [#2] jquery.html Cycles:180 Average:21263.64 Median:4747.47 stddev:52526.54 (1106.4%) stddev-sans-first:52650.40 07:18:19 INFO - PROCESS | 9936 | Values: 343.8 358.6 368.8 373.3 383.2 12423.5 12736.7 12932.1 13122.1 16315.4 16123.7 16289.1 16320.8 16374.4 16400.7 4645.9 4702.7 4790.7 4832.1 4867.1 4718.5 4804.2 4808.3 4809.3 4810.2 3898.0 4772.5 4790.0 4791.4 4792.7 4731.7 4763.2 4766.7 4770.3 4771.2 4202.6 4254.1 4300.3 4303.5 4303.8 18379.6 18672.8 19054.2 19449.9 19466.0 1841.2 1868.5 1883.5 2081.6 2449.8 11777.7 12365.0 12418.5 12840.8 13031.4 1655.5 1684.2 1751.4 1772.4 1773.0 61212.0 63458.0 63806.0 65009.0 65130.7 8925.5 9195.8 9198.1 9333.4 9369.5 12835.5 12846.4 12848.7 12849.4 12861.5 6436.4 6638.8 6710.1 6726.5 6875.9 6187.4 6283.5 6459.9 6460.5 6503.6 5766.4 5841.5 5877.8 5937.2 6104.5 1682.3 1712.9 1729.3 1730.1 1749.6 781.5 826.0 827.2 849.4 934.8 15789.7 16510.2 16606.5 16794.9 17014.5 755.9 791.5 812.6 838.0 862.6 8840.7 9300.2 9633.3 9807.1 9913.9 275905.0 281953.0 282447.0 359546.0 370695.0 55364.0 67799.3 68566.3 70844.6 74843.0 887.5 892.3 914.5 929.4 932.2 11019.9 14134.9 15043.4 15185.6 15397.4 34609.7 34717.7 34744.1 35729.0 36728.0 44596.6 44676.6 45099.3 46042.5 47692.0 6762.3 6942.4 6984.5 7378.7 7388.6 9019.1 10595.7 11365.7 11545.6 11721.2 9553.1 9741.1 9923.1 9978.5 10206.0 9541.8 9984.6 10029.4 10202.2 10221.1 9712.9 9794.7 10116.4 10209.6 10594.8 7401.0 7547.4 7711.5 7800.3 7998.8 8535.0 9278.2 9666.8 9960.1 10239.8 07:18:19 INFO - PROCESS | 9936 | 07:18:19 INFO - PROCESS | 9936 | [#3] mootools.html Cycles:180 Average:4678.12 Median:5541.07 stddev:2514.90 (45.4%) stddev-sans-first:2508.71 07:18:19 INFO - PROCESS | 9936 | Values: 1244.6 1327.9 1330.0 1630.8 1680.6 6247.2 6458.2 6575.0 6927.6 6930.6 6766.6 7071.5 7075.9 7242.5 7260.2 2053.5 2078.5 2082.7 2089.0 2090.7 1776.2 1839.3 2044.5 2084.4 2097.8 1962.6 2040.7 2045.2 2056.7 2064.6 2054.4 2056.4 2090.8 2101.7 2106.6 2077.8 2131.1 2132.7 2135.5 2137.4 7227.6 7286.9 7288.7 7289.0 7289.4 4080.7 4203.0 4222.9 4420.4 4421.6 2635.4 2720.9 2816.5 2818.6 2828.4 881.1 886.7 888.5 891.9 906.5 9354.9 9388.8 9397.1 9409.3 9409.9 3630.2 3863.2 3907.9 3927.0 4027.7 8254.5 8260.0 8280.8 8280.8 8281.8 4429.8 4431.8 4433.9 4434.1 4434.7 3810.6 4051.1 4053.9 4058.9 4059.5 3288.3 3358.8 3428.6 3438.0 3529.4 992.6 1022.9 1101.1 1113.5 1124.4 711.3 734.1 779.7 790.8 818.1 4698.6 4768.1 4775.9 4851.3 4853.1 781.8 816.8 835.2 836.3 840.8 3146.3 3278.9 3307.5 3321.5 3384.1 7949.9 8063.7 8215.5 8307.5 8636.1 8505.7 8509.3 8514.0 8526.9 8533.7 6498.3 6593.7 6675.4 6735.9 6736.3 4963.0 5041.1 5073.9 5092.1 5162.7 7415.3 7636.9 7642.8 7737.3 7884.1 7880.6 7980.2 8017.8 8037.7 8042.0 6132.6 6308.7 6308.9 6310.8 6312.2 6755.4 6768.6 6807.4 6809.4 6817.7 6173.8 6174.7 6185.5 6191.8 6227.4 6070.6 6086.5 6123.5 6132.0 6177.9 5509.6 5521.3 5560.8 5561.9 5565.6 4192.9 4215.8 4249.1 4294.4 4342.2 4304.7 4349.0 4364.9 4366.8 4373.8 07:18:19 INFO - PROCESS | 9936 | 07:18:19 INFO - PROCESS | 9936 | [#4] prototype.html Cycles:180 Average:4118.55 Median:4673.24 stddev:1204.69 (25.8%) stddev-sans-first:1173.36 07:18:19 INFO - PROCESS | 9936 | Values: 293.6 294.7 298.3 306.7 309.9 4830.5 4851.8 4866.2 4882.9 4886.8 4778.4 4784.9 4825.7 4871.2 4872.7 3818.9 3819.7 3821.0 3831.6 3836.3 3713.8 3802.4 3837.6 3849.6 3851.3 3713.3 3740.2 3744.1 3744.3 3753.7 3711.2 3714.6 3720.6 3737.1 3740.2 3158.6 3246.4 3247.6 3285.2 3294.8 4645.5 4659.1 4672.6 4679.5 4696.5 4295.2 4298.8 4306.8 4306.8 4308.4 4673.8 4796.4 4994.9 5004.7 5039.7 3575.9 3579.6 3592.0 3606.8 3612.1 5177.3 5199.0 5199.6 5202.6 5224.2 3580.3 3672.1 3686.9 3691.2 3694.1 3697.4 3723.7 3725.3 3749.9 3757.4 4231.7 4241.9 4262.2 4272.3 4298.5 5036.8 5039.3 5041.2 5052.7 5056.3 1279.2 1312.6 1327.8 1328.0 1332.8 808.2 850.6 858.9 862.8 864.4 3950.7 3952.2 3959.8 3964.4 3964.8 4487.3 4532.4 4534.8 4544.9 4567.5 3947.8 3950.2 3958.0 3960.5 3965.4 2272.5 2444.6 2457.6 2465.7 2470.5 4315.5 4625.5 4647.8 4784.8 4810.1 5217.5 5221.9 5260.3 5271.4 5293.7 4800.4 4801.4 4802.1 4806.6 4855.4 4965.8 5111.9 5124.3 5128.9 5186.2 4979.7 4998.3 5004.9 5014.7 5026.5 4840.8 4840.9 4848.2 4851.0 4852.3 3455.3 3660.3 3669.9 3676.7 3683.3 5201.6 5206.7 5216.1 5223.9 5264.9 5027.9 5073.4 5076.2 5097.7 5108.7 4943.7 4972.0 5011.7 5024.6 5055.4 4924.7 4928.2 4930.0 4932.4 4942.6 5039.2 5041.6 5044.4 5049.3 5055.4 4757.4 4980.5 5013.2 5015.7 5021.2 07:18:19 INFO - PROCESS | 9936 | 07:18:19 INFO - PROCESS | 9936 | [#5] yui.html Cycles:180 Average:14439.30 Median:57068.86 stddev:18855.39 (33.0%) stddev-sans-first:18879.69 07:18:19 INFO - PROCESS | 9936 | Values: 609.6 661.8 713.1 731.9 740.8 11970.7 12889.2 12893.0 12922.1 12960.2 12230.5 12348.4 12356.9 12369.8 12373.4 616.2 636.8 731.1 776.3 784.2 785.5 788.2 789.3 789.4 789.4 647.2 843.3 846.0 846.1 847.4 670.6 821.9 843.0 843.9 852.2 612.9 613.5 614.7 616.9 616.9 12700.4 12718.6 12726.5 12753.9 12756.7 12948.6 12958.0 13071.3 13255.9 13298.1 10039.7 10076.8 10222.1 10281.1 10333.9 3305.8 3308.2 3348.6 3363.7 3364.5 46427.5 46807.8 48059.5 48095.3 48168.0 8367.7 8604.3 8742.5 8901.4 8960.7 15799.3 15946.4 15954.0 15975.5 16090.2 6250.0 6301.6 6419.5 6579.1 6598.2 3495.9 3542.6 3562.2 3601.1 3622.5 2597.1 2681.4 2686.0 2694.5 2695.9 467.7 508.4 522.6 530.1 540.1 485.9 555.3 591.3 593.5 596.2 6974.7 7283.9 7478.6 7771.5 7808.1 581.9 592.1 603.7 607.7 614.3 3592.9 3651.7 3685.9 3692.3 3763.7 65365.0 69885.7 70189.3 70651.3 72764.3 59826.0 63808.7 65270.3 65651.7 65978.0 56232.7 56679.0 57458.7 57885.4 58042.1 7076.4 7111.7 7253.3 7437.7 7559.0 33611.5 34818.0 35913.0 36245.3 37177.4 47521.5 49712.3 50069.7 50258.5 50600.5 9234.6 9541.0 9595.0 9610.0 9614.9 10469.4 10483.7 10660.4 10796.4 10902.5 9469.6 9642.3 9703.6 10055.1 10481.0 10151.3 10466.3 10559.3 10593.0 10616.0 10249.6 10375.2 10405.6 10427.4 10550.7 8942.4 9137.7 9234.3 9511.8 9650.0 8947.6 9551.2 9574.9 9602.3 9664.6 07:18:19 INFO - PROCESS | 9936 | -------- Summary: end -------- 07:18:19 INFO - PROCESS | 9936 | 07:18:20 INFO - TEST-INFO | 9936: exit 0 07:18:20 INFO - TEST-OK | dromaeo_css | took 1122431ms 07:18:20 INFO - TEST-START | kraken 07:18:20 INFO - operating with platform_type : linux_ 07:18:20 INFO - Initialising browser for kraken test... 07:18:20 INFO - TEST-INFO | started process 10247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptHyPct/profile http://localhost:59697/getInfo.html) 07:18:24 INFO - PROCESS | 10247 | __metrics Screen width/height:1600/1200 07:18:24 INFO - PROCESS | 10247 | colorDepth:24 07:18:24 INFO - PROCESS | 10247 | Browser inner width/height: 1024/697 07:18:24 INFO - PROCESS | 10247 | __metrics 07:18:25 INFO - PROCESS | 10247 | 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" 07:18:25 INFO - PROCESS | 10247 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:18:26 INFO - PROCESS | 10247 | console.error: PushService: 07:18:26 INFO - PROCESS | 10247 | stateChangeProcessEnqueue: Error transitioning state 07:18:26 INFO - PROCESS | 10247 | UnknownError 07:18:26 INFO - TEST-INFO | 10247: exit 0 07:18:26 INFO - Browser initialized. 07:18:26 INFO - Running cycle 1/1 for kraken test... 07:18:26 INFO - TEST-INFO | started process 10330 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptHyPct/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:18:39 INFO - PROCESS | 10330 | RSS: Main: 174112768 07:18:39 INFO - PROCESS | 10330 | 07:18:41 INFO - PROCESS | 10330 | Cycle 1(1): loaded http://localhost:59697/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59697/tests/kraken/driver.html?testName=audio-beat-detection) 07:18:42 INFO - PROCESS | 10330 | RSS: Main: 230526976 07:18:42 INFO - PROCESS | 10330 | 07:18:45 INFO - PROCESS | 10330 | Cycle 1(1): loaded http://localhost:59697/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59697/tests/kraken/driver.html?testName=audio-dft) 07:18:46 INFO - PROCESS | 10330 | RSS: Main: 217243648 07:18:46 INFO - PROCESS | 10330 | 07:18:49 INFO - PROCESS | 10330 | Cycle 1(1): loaded http://localhost:59697/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59697/tests/kraken/driver.html?testName=audio-fft) 07:18:50 INFO - PROCESS | 10330 | RSS: Main: 299208704 07:18:50 INFO - PROCESS | 10330 | 07:18:52 INFO - PROCESS | 10330 | Cycle 1(1): loaded http://localhost:59697/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59697/tests/kraken/driver.html?testName=audio-oscillator) 07:18:52 INFO - PROCESS | 10330 | RSS: Main: 210886656 07:18:52 INFO - PROCESS | 10330 | 07:18:55 INFO - PROCESS | 10330 | Cycle 1(1): loaded http://localhost:59697/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59697/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:18:55 INFO - PROCESS | 10330 | RSS: Main: 213258240 07:18:55 INFO - PROCESS | 10330 | 07:18:58 INFO - PROCESS | 10330 | Cycle 1(1): loaded http://localhost:59697/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59697/tests/kraken/driver.html?testName=imaging-darkroom) 07:18:59 INFO - PROCESS | 10330 | RSS: Main: 248967168 07:18:59 INFO - PROCESS | 10330 | 07:19:02 INFO - PROCESS | 10330 | Cycle 1(1): loaded http://localhost:59697/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59697/tests/kraken/driver.html?testName=imaging-desaturate) 07:19:03 INFO - PROCESS | 10330 | RSS: Main: 248569856 07:19:03 INFO - PROCESS | 10330 | 07:19:06 INFO - PROCESS | 10330 | Cycle 1(1): loaded http://localhost:59697/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59697/tests/kraken/driver.html?testName=json-parse-financial) 07:19:06 INFO - PROCESS | 10330 | RSS: Main: 247971840 07:19:06 INFO - PROCESS | 10330 | 07:19:08 INFO - PROCESS | 10330 | Cycle 1(1): loaded http://localhost:59697/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59697/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:19:09 INFO - PROCESS | 10330 | RSS: Main: 210681856 07:19:09 INFO - PROCESS | 10330 | 07:19:10 INFO - PROCESS | 10330 | Cycle 1(1): loaded http://localhost:59697/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59697/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:19:11 INFO - PROCESS | 10330 | RSS: Main: 217587712 07:19:11 INFO - PROCESS | 10330 | 07:19:13 INFO - PROCESS | 10330 | Cycle 1(1): loaded http://localhost:59697/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59697/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:19:14 INFO - PROCESS | 10330 | RSS: Main: 227188736 07:19:14 INFO - PROCESS | 10330 | 07:19:17 INFO - PROCESS | 10330 | Cycle 1(1): loaded http://localhost:59697/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59697/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:19:18 INFO - PROCESS | 10330 | RSS: Main: 235642880 07:19:18 INFO - PROCESS | 10330 | 07:19:21 INFO - PROCESS | 10330 | Cycle 1(1): loaded http://localhost:59697/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59697/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:19:21 INFO - PROCESS | 10330 | RSS: Main: 232181760 07:19:21 INFO - PROCESS | 10330 | 07:19:23 INFO - PROCESS | 10330 | Cycle 1(1): loaded http://localhost:59697/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59697/tests/kraken/driver.html?testName=ai-astar) 07:19:23 INFO - PROCESS | 10330 | RSS: Main: 283078656 07:19:23 INFO - PROCESS | 10330 | 07:19:23 INFO - PROCESS | 10330 | __start_tp_report 07:19:23 INFO - PROCESS | 10330 | _x_x_mozilla_page_load 07:19:23 INFO - PROCESS | 10330 | _x_x_mozilla_page_load_details 07:19:23 INFO - PROCESS | 10330 | |i|pagename|runs| 07:19:23 INFO - PROCESS | 10330 | |0;ai-astar;107;116;116;115;116;116;114;116;116;116 07:19:23 INFO - PROCESS | 10330 | |1;audio-beat-detection;155;127;133;172;133;129;131;135;161;127 07:19:23 INFO - PROCESS | 10330 | |2;audio-dft;162;161;162;160;161;160;162;161;161;164 07:19:23 INFO - PROCESS | 10330 | |3;audio-fft;77;76;76;108;77;76;77;75;98;75 07:19:23 INFO - PROCESS | 10330 | |4;audio-oscillator;84;84;126;84;83;84;113;83;84;111 07:19:23 INFO - PROCESS | 10330 | |5;imaging-gaussian-blur;117;116;116;117;117;117;116;117;117;117 07:19:23 INFO - PROCESS | 10330 | |6;imaging-darkroom;147;147;146;146;146;146;147;148;146;146 07:19:23 INFO - PROCESS | 10330 | |7;imaging-desaturate;84;84;85;88;84;85;84;84;84;84 07:19:23 INFO - PROCESS | 10330 | |8;json-parse-financial;63;63;61;70;63;61;62;62;64;63 07:19:23 INFO - PROCESS | 10330 | |9;json-stringify-tinderbox;65;66;66;65;67;65;65;67;66;69 07:19:23 INFO - PROCESS | 10330 | |10;stanford-crypto-aes;84;84;85;83;92;85;83;83;83;83 07:19:23 INFO - PROCESS | 10330 | |11;stanford-crypto-ccm;142;150;152;139;147;153;148;141;183;143 07:19:23 INFO - PROCESS | 10330 | |12;stanford-crypto-pbkdf2;181;182;181;179;182;177;185;177;183;176 07:19:23 INFO - PROCESS | 10330 | |13;stanford-crypto-sha256-iterative;74;70;70;70;74;73;71;72;69;70 07:19:23 INFO - PROCESS | 10330 | __end_tp_report 07:19:23 INFO - PROCESS | 10330 | __start_cc_report 07:19:23 INFO - PROCESS | 10330 | _x_x_mozilla_cycle_collect,1964 07:19:23 INFO - PROCESS | 10330 | __end_cc_report 07:19:23 INFO - PROCESS | 10330 | __startTimestamp1477664363669__endTimestamp 07:19:23 INFO - PROCESS | 10330 | 07:19:23 INFO - PROCESS | 10330 | ------- Summary: start ------- 07:19:23 INFO - PROCESS | 10330 | Number of tests: 14 07:19:23 INFO - PROCESS | 10330 | 07:19:23 INFO - PROCESS | 10330 | [#0] ai-astar Cycles:10 Average:114.80 Median:116.00 stddev:2.82 (2.4%) stddev-sans-first:0.71 07:19:23 INFO - PROCESS | 10330 | Values: 107.0 116.0 116.0 115.0 116.0 116.0 114.0 116.0 116.0 116.0 07:19:23 INFO - PROCESS | 10330 | 07:19:23 INFO - PROCESS | 10330 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:134.00 stddev:16.17 (12.1%) stddev-sans-first:16.25 07:19:23 INFO - PROCESS | 10330 | Values: 155.0 127.0 133.0 172.0 133.0 129.0 131.0 135.0 161.0 127.0 07:19:23 INFO - PROCESS | 10330 | 07:19:23 INFO - PROCESS | 10330 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.22 07:19:23 INFO - PROCESS | 10330 | Values: 162.0 161.0 162.0 160.0 161.0 160.0 162.0 161.0 161.0 164.0 07:19:23 INFO - PROCESS | 10330 | 07:19:23 INFO - PROCESS | 10330 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.50 stddev:11.60 (15.2%) stddev-sans-first:12.19 07:19:23 INFO - PROCESS | 10330 | Values: 77.0 76.0 76.0 108.0 77.0 76.0 77.0 75.0 98.0 75.0 07:19:23 INFO - PROCESS | 10330 | 07:19:23 INFO - PROCESS | 10330 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:84.00 stddev:16.38 (19.5%) stddev-sans-first:17.00 07:19:23 INFO - PROCESS | 10330 | Values: 84.0 84.0 126.0 84.0 83.0 84.0 113.0 83.0 84.0 111.0 07:19:23 INFO - PROCESS | 10330 | 07:19:23 INFO - PROCESS | 10330 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:19:23 INFO - PROCESS | 10330 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 07:19:23 INFO - PROCESS | 10330 | 07:19:23 INFO - PROCESS | 10330 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 07:19:23 INFO - PROCESS | 10330 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 147.0 148.0 146.0 146.0 07:19:23 INFO - PROCESS | 10330 | 07:19:23 INFO - PROCESS | 10330 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:84.00 stddev:1.26 (1.5%) stddev-sans-first:1.32 07:19:23 INFO - PROCESS | 10330 | Values: 84.0 84.0 85.0 88.0 84.0 85.0 84.0 84.0 84.0 84.0 07:19:23 INFO - PROCESS | 10330 | 07:19:23 INFO - PROCESS | 10330 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.00 stddev:2.57 (4.1%) stddev-sans-first:2.73 07:19:23 INFO - PROCESS | 10330 | Values: 63.0 63.0 61.0 70.0 63.0 61.0 62.0 62.0 64.0 63.0 07:19:23 INFO - PROCESS | 10330 | 07:19:23 INFO - PROCESS | 10330 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:1.29 (1.9%) stddev-sans-first:1.30 07:19:23 INFO - PROCESS | 10330 | Values: 65.0 66.0 66.0 65.0 67.0 65.0 65.0 67.0 66.0 69.0 07:19:23 INFO - PROCESS | 10330 | 07:19:23 INFO - PROCESS | 10330 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.00 stddev:2.76 (3.3%) stddev-sans-first:2.92 07:19:23 INFO - PROCESS | 10330 | Values: 84.0 84.0 85.0 83.0 92.0 85.0 83.0 83.0 83.0 83.0 07:19:23 INFO - PROCESS | 10330 | 07:19:23 INFO - PROCESS | 10330 | [#11] stanford-crypto-ccm Cycles:10 Average:149.80 Median:149.00 stddev:12.60 (8.5%) stddev-sans-first:13.05 07:19:23 INFO - PROCESS | 10330 | Values: 142.0 150.0 152.0 139.0 147.0 153.0 148.0 141.0 183.0 143.0 07:19:23 INFO - PROCESS | 10330 | 07:19:23 INFO - PROCESS | 10330 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.30 Median:181.50 stddev:2.95 (1.6%) stddev-sans-first:3.11 07:19:23 INFO - PROCESS | 10330 | Values: 181.0 182.0 181.0 179.0 182.0 177.0 185.0 177.0 183.0 176.0 07:19:23 INFO - PROCESS | 10330 | 07:19:23 INFO - PROCESS | 10330 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.50 stddev:1.83 (2.6%) stddev-sans-first:1.66 07:19:23 INFO - PROCESS | 10330 | Values: 74.0 70.0 70.0 70.0 74.0 73.0 71.0 72.0 69.0 70.0 07:19:23 INFO - PROCESS | 10330 | -------- Summary: end -------- 07:19:23 INFO - PROCESS | 10330 | 07:19:25 INFO - TEST-INFO | 10330: exit 0 07:19:25 INFO - TEST-OK | kraken | took 64868ms 07:19:25 INFO - SUITE-END | took 1187s 07:19:25 INFO - Completed test suite (00:19:47) 07:19:25 INFO - javascript benchmark 07:19:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2509.7615726505983, 2545.618157276409, 2557.8081643876712, 2563.4104156044123, 2573.819832611718, 4463.0, 4486.461624605044, 4530.207213737599, 4546.272596384575, 4560.247559152735, 4574.83988060418, 4625.352450656911, 4676.97661511692, 4705.882352941178, 4748.667593268473, 4152.252594532983, 4177.937330940038, 4219.641330486897, 4246.087091275375, 4247.469066366704, 4254.340577210522, 4322.675799315049, 4357.063231405247, 4363.80362883671, 4412.492563355223, 4156.937645935283, 4273.7008409411355, 4279.251131052053, 4285.292926667096, 4378.6934914555995, 4206.158768246332, 4261.339492378686, 4270.487541495009, 4274.209271284792, 4277.550857159985, 4162.250794856925, 4251.893702657459, 4256.723312984646, 4258.53156152823, 4272.316429371285, 4546.0680560485025, 4555.544445555418, 4560.179167749804, 4606.884827879297, 4625.745583992879, 4841.951580484185, 4847.733374664392, 4853.563179313879, 4854.951450485485, 4917.582005529534, 4832.516748325139, 4878.780454879539, 4881.51184881509, 4895.437024742165, 4940.28365886948, 4549.7042692224895, 4605.032943081923, 4616.630669546428, 4619.076184762994, 4681.438227412664, 5030.924536131961, 5033.144365457881, 5034.622403319766, 5040.54635082837, 5093.210552364315, 4781.306710527024, 4824.059308434892, 4828.275758636162, 4833.73414462208, 4885.658003939761, 4727.621790256771, 4782.0914026334885, 4788.4253889533475, 4885.6335774817035, 4912.72979986097, 4883.34074899891, 4900.803967841318, 4943.110240156734, 4958.9008219835405, 4962.851114466572, 4880.243562247857, 4888.706677599284, 4888.902221955612, 4894.902101957941, 4950.356453661001, 3759.71802114837, 3805.2199299144163, 3808.4858544096746, 3937.5078115235597, 3946.6053394660303, 3390.4914262860766, 3416.3850506908993, 3426.1605906553054, 3428.074419906611, 3476.878309259164, 4173.874783756492, 4175.582441755861, 4179.623833854967, 4220.535741068541, 4227.0, 4751.928721069186, 4826.058918510927, 4833.3958255218095, 4839.758012099381, 4895.412550493892, 4146.440230568895, 4155.625993660585, 4202.075543380452, 4203.810828512663, 4206.831726730958, 4385.451818522684, 4422.889427764268, 4428.601425871622, 4431.357453169272, 4431.357453169337, 4529.8641040768825, 4547.090581883636, 4554.2257816172, 4555.567221113989, 4566.45202575693, 4851.830185943475, 4937.382827146606, 4946.134426475281, 4946.925796113133, 4947.82682606107, 4558.749268790249, 4561.315802629632, 4566.840160594364, 4569.565891240327, 4626.629869610356, 4790.377250957354, 4805.903881922272, 4808.783604737865, 4816.8795780105775, 4821.252705830602, 4781.115493633689, 4797.928031079607, 4831.855044348676, 4866.951330486791, 4868.245421959602, 4711.0, 4716.1510928033285, 4717.457492388419, 4751.786169622306, 4774.618030557616, 4727.834525791581, 4732.171869922819, 4737.976310118427, 4783.904321913612, 4789.736564488987, 4598.333241680005, 4644.0944015916575, 4660.86017419478, 4662.5104364042645, 4663.044075964352, 4756.381670382828, 4795.256735206049, 4797.280407938837, 4838.2016967201425, 4859.31969524274, 4689.859304220879, 4700.788464519173, 4701.717896926195, 4763.1426343258545, 4763.16644587189], "value": 4476.354535592581, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.78481000005, 549.2776998247305, 552.4861878453039, 561.9297587801525, 562.4768964862677, 38732.41901371478, 40450.595494045054, 40484.59515404849, 43704.0, 44342.33486497705, 39829.402558961636, 40433.7978310108, 40458.0, 40537.391939120935, 40597.39103913444, 7630.7710768677025, 7763.534187948713, 7764.922350776505, 7772.4947878388, 7773.883391749128, 7754.185810489902, 7826.72606458774, 7830.29527342539, 7831.138574756772, 7833.569153696544, 7820.960895195516, 7830.021247344082, 7853.489523181003, 7858.410619203554, 7864.449488535776, 7738.806529836743, 7780.844383112306, 7782.494137881048, 7824.21757824213, 7836.725714600018, 7669.501482403626, 7741.419393545507, 7744.303012728825, 7744.41916856238, 7781.572013539253, 37783.433248501016, 38320.80839595812, 38321.42517862234, 38350.80824595887, 38396.42405363922, 2973.3458639099363, 2974.375381169957, 2987.507061334877, 3128.3117714103087, 3297.653746356622, 28156.296092597644, 28184.577231341547, 28303.433931321466, 28494.927557790157, 28716.13851584456, 3045.725884670368, 3067.371188906269, 3103.5965324507897, 3161.0674850919036, 3199.1027028100057, 240135.0, 241128.0, 242858.7857060721, 243595.0, 244079.0, 44613.33080003803, 44875.551244487135, 44890.55109448929, 44959.55040449554, 44963.55036449594, 31541.36917261688, 32316.35367292641, 32524.512132318036, 34276.828615856764, 52514.47485525172, 14892.851071489147, 15071.321790519452, 15073.698526029419, 15094.622634434007, 15095.245237738069, 11317.547298107984, 11453.427328633536, 11457.427128643534, 11457.656270311738, 11460.0, 17936.372226972253, 17992.370267040853, 18025.459236222934, 18101.366452174112, 18152.183151758203, 6634.734610615618, 6662.800115996528, 6780.491463140284, 6808.114945057111, 7092.716291348392, 702.3923064695613, 801.9879701804477, 811.7443005453264, 825.5748289630845, 837.4640230252643, 26639.600405993926, 26672.59991100135, 26826.15502747352, 26974.32564185872, 27397.863010684818, 712.4834494991194, 897.4480694373044, 949.852772820214, 963.6482683820495, 971.5433746139303, 13818.723625527433, 13876.306184690726, 14202.715945681235, 14270.429182832779, 14474.421023158955, 362008.0, 364980.0, 365692.0, 366068.0, 366121.0, 48856.0, 49235.50764492381, 49235.75382123067, 49340.50659493431, 49377.75311123421, 986.9309148359689, 1000.049952545085, 1037.4760745823462, 1075.725689949058, 1088.216484131424, 25143.74856251414, 27374.863125684245, 28415.715842842135, 28752.85623571869, 29202.269943251587, 46250.53749462462, 46846.53153468558, 46902.53097469118, 46936.29595556001, 46980.29529556991, 355137.2431378369, 358067.0, 358376.0, 358783.0, 359088.0, 24060.87969560141, 24548.263552093467, 24918.37704057413, 25885.741142588333, 37524.249515009, 41003.12978091624, 41302.38046429366, 41397.0, 41694.374584380654, 41935.370969436095, 34844.65155348516, 35557.28885422329, 35649.643503564635, 35901.461478078374, 36020.09949751277, 35002.64997349994, 35071.47392789059, 35232.29535409329, 35427.0, 35555.822220889764, 33246.83376583102, 33931.4910276351, 34108.82945585256, 34946.47580286247, 35442.291154177285, 30071.69928300689, 31920.6807931927, 32143.0, 32365.0, 32521.674783251863, 24713.752862471145, 24721.72646419914, 24811.751882480945, 24897.0, 25114.748852511973], "value": 17033.97199319235, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.8074678180218, 358.6288191721567, 368.7676763638908, 373.30565148823194, 383.2488322887141, 12423.503059877594, 12736.681582960431, 12932.094753367257, 13122.081454298203, 16315.428959986402, 16123.677526449494, 16289.104099274535, 16320.83679163208, 16374.426895058676, 16400.67198656026, 4645.88385290367, 4702.717836929795, 4790.688605240665, 4832.106060378841, 4867.123917694814, 4718.504557021515, 4804.183288840905, 4808.2547205183255, 4809.302651115586, 4810.206315957863, 3897.9610203898023, 4772.451168115659, 4790.041991601676, 4791.377120974268, 4792.664513484057, 4731.739754313511, 4763.190257656207, 4766.713997160182, 4770.332153498478, 4771.212749896263, 4202.558731333196, 4254.074922069744, 4300.333448315516, 4303.462067241595, 4303.784810759449, 18379.63240735178, 18672.813271867242, 19054.237830486763, 19449.90275048616, 19466.0, 1841.1990784008865, 1868.504846215754, 1883.4726276642562, 2081.552466219755, 2449.816263780224, 11777.705557361134, 12365.0, 12418.503259869685, 12840.807387889188, 13031.413586388635, 1655.4867990922853, 1684.2420910590283, 1751.3870145449118, 1772.397384889131, 1772.9911350443294, 61212.0, 63458.0, 63806.0, 65008.99999999953, 65130.67434662844, 8925.464472131693, 9195.77010574741, 9198.080191980882, 9333.353321240687, 9369.48467834262, 12835.48658053686, 12846.357682116044, 12848.678783030498, 12849.357532123357, 12861.549845755353, 6436.388543088399, 6638.800835974928, 6710.127683401224, 6726.529142960044, 6875.896861547081, 6187.412195841388, 6283.5287353448675, 6459.870802583922, 6460.483161347081, 6503.626176445563, 5766.365699773021, 5841.503472204825, 5877.794277200363, 5937.168796368512, 6104.450599445982, 1682.3186609423203, 1712.914354282281, 1729.325563030419, 1730.0830559803323, 1749.6238308763677, 781.5193655901579, 826.01703972274, 827.210014436212, 849.3757088539918, 934.7569631895756, 15789.68420631581, 16510.17449127539, 16606.50180494587, 16794.916025419796, 17014.48956531306, 755.8586534333197, 791.4538968112099, 812.5937031484258, 837.9664813407518, 862.6118246788844, 8840.734777956543, 9300.162985331353, 9633.277504187214, 9807.117359437685, 9913.900860991442, 275905.0, 281953.0, 282447.0, 359546.0, 370695.0, 55364.0, 67799.32200678029, 68566.314336856, 70844.64577677182, 74843.0, 887.5296093070683, 892.3352102683542, 914.5198770645331, 929.3587424676952, 932.2262522106771, 11019.889801101886, 14134.929325353307, 15043.398264069314, 15185.6203594911, 15397.384104635688, 34609.65390346065, 34717.652823472454, 34744.13139671528, 35729.0, 36728.0, 44596.55403446054, 44676.55323446724, 45099.323510146714, 46042.539574605165, 47692.0, 6762.289959554176, 6942.361902477026, 6984.546004509691, 7378.741744038933, 7388.593627350548, 9019.143181397756, 10595.735106622396, 11365.715857103307, 11545.595904143314, 11721.179517433698, 9553.140217380469, 9741.074597913186, 9923.057309555581, 9978.501074946369, 10205.965556603482, 9541.761455963657, 9984.550695218877, 10029.398236105857, 10202.234832387749, 10221.131203847755, 9712.854307185256, 9794.65718699842, 10116.443595602312, 10209.591616335263, 10594.788104238027, 7401.0, 7547.433942454228, 7711.498752581064, 7800.258975397328, 7998.760037198894, 8535.0, 9278.211352035152, 9666.806663866542, 9960.103590676874, 10239.84640230412], "value": 7791.0712423823115, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1244.5706231350186, 1327.8804907558317, 1330.029078772496, 1630.779363121189, 1680.55465301695, 6247.18786557748, 6458.160439142916, 6575.0, 6927.618980956046, 6930.5841649501, 6766.560173588713, 7071.469639777025, 7075.85848283034, 7242.456815738814, 7260.23767504411, 2053.4968932611496, 2078.490769761411, 2082.739657542807, 2088.98955505223, 2090.7282053333047, 1776.2450958342718, 1839.264294282291, 2044.509317763741, 2084.3642688979853, 2097.769245383007, 1962.57804572017, 2040.6632905570564, 2045.1819272291054, 2056.7017782421613, 2064.6077245323418, 2054.352878843167, 2056.393363957636, 2090.843186760999, 2101.7162683037745, 2106.5786842631383, 2077.8233850122756, 2131.1475409836034, 2132.744070711509, 2135.487483004068, 2137.358792362285, 7227.638618069075, 7286.890696639554, 7288.708451661927, 7289.015982842355, 7289.38040266578, 4080.7143499955014, 4202.978985105055, 4222.852200172979, 4420.381146639473, 4421.646268298528, 2635.420207554335, 2720.8911643534234, 2816.450792095542, 2818.5631227159824, 2828.3777568935006, 881.1364862434785, 886.7428445750725, 888.5335199020501, 891.8528442806929, 906.4515967839494, 9354.859677104849, 9388.765280867965, 9397.060293970617, 9409.29430292724, 9409.858852117224, 3630.2013557017412, 3863.150106976461, 3907.902302442462, 3926.980365098156, 4027.677785777131, 8254.504729716236, 8259.95870020658, 8280.792980175424, 8280.83438331242, 8281.751547453587, 4429.778511074498, 4431.7562534060935, 4433.911321773547, 4434.113177364476, 4434.689571729948, 3810.580836108026, 4051.1290072634524, 4053.8783836484954, 4058.857939972087, 4059.4925634295714, 3288.309455014426, 3358.7816791908936, 3428.6057103433423, 3438.020164253176, 3529.400001999666, 992.5979978108877, 1022.9130523905551, 1101.0640955188026, 1113.5323164271026, 1124.4321617583068, 711.2851584157888, 734.1483878700682, 779.734890137356, 790.7864876483317, 818.083746204255, 4698.577128058491, 4768.070226305837, 4775.856724298276, 4851.320815085891, 4853.12643724126, 781.7967328494518, 816.7876352148484, 835.2232423845882, 836.3142223376773, 840.8318336332758, 3146.2606287522412, 3278.852451639634, 3307.503874418808, 3321.485169798685, 3384.0693809202176, 7949.920500795034, 8063.717769878143, 8215.465994710445, 8307.543085130255, 8636.093210212837, 8505.659773608986, 8509.319254459751, 8513.95743021281, 8526.87209691855, 8533.738559281795, 6498.252700939358, 6593.703283352261, 6675.432588229958, 6735.932640673628, 6736.2590115087305, 4963.0, 5041.143005689115, 5073.898522029465, 5092.0579692756955, 5162.741862906914, 7415.258474152542, 7636.885446718193, 7642.770716878503, 7737.3036426721865, 7884.1327453978865, 7880.566568838769, 7980.201979801974, 8017.759467215993, 8037.718679846177, 8041.959790201246, 6132.601380910227, 6308.684565771601, 6308.936910631019, 6310.810675679737, 6312.242530896322, 6755.4257888080065, 6768.593884366756, 6807.3873351398615, 6809.38715515606, 6817.659117044227, 6173.783917562864, 6174.722137503913, 6185.505159587312, 6191.81424557264, 6227.377262273736, 6070.605410648293, 6086.452219300284, 6123.540734444845, 6132.0, 6177.938220617916, 5509.614326997072, 5521.309836270466, 5560.833175004756, 5561.888762224652, 5565.638233514808, 4192.9161416770885, 4215.768132752728, 4249.107687385684, 4294.377315289203, 4342.196693611692, 4304.6556275498515, 4348.978255108705, 4364.912701745884, 4366.847160349373, 4373.825046998211], "value": 3818.590308096512, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.5919072489239, 294.7479904681497, 298.2841181165204, 306.6871790773413, 309.92097015261106, 4830.492798256185, 4851.81130622997, 4866.24573191155, 4882.902341953163, 4886.804527818883, 4778.3549220855175, 4784.880377990552, 4825.686330388522, 4871.220604703248, 4872.70763754175, 3818.854343696894, 3819.6631179087235, 3820.9808950955207, 3831.61683831616, 3836.251930873481, 3713.758605690635, 3802.4106263529197, 3837.635424634669, 3849.5957924417953, 3851.28751181031, 3713.275911197318, 3740.214554943465, 3744.120131769032, 3744.326021316162, 3753.662170404663, 3711.183539621279, 3714.591394946554, 3720.5907350191455, 3737.121776382548, 3740.1584643455276, 3158.5735925649974, 3246.4156451838658, 3247.610286765603, 3285.227971426713, 3294.8187849668257, 4645.512221216791, 4659.138059458977, 4672.649551283667, 4679.508651591568, 4696.483386827446, 4295.248331541968, 4298.828046878121, 4306.8277268909205, 4306.849260275875, 4308.3968244445805, 4673.836415725434, 4796.3524924135145, 4994.875128121826, 5004.749762511859, 5039.697618142924, 3575.928481430357, 3579.6062433132333, 3592.0, 3606.801625910574, 3612.1330880588735, 5177.275181474596, 5199.0, 5199.558037566773, 5202.583793296527, 5224.164133738622, 3580.2839432113683, 3672.1186915140706, 3686.870959516458, 3691.187938653492, 3694.131879008431, 3697.4453831925425, 3723.72072094594, 3725.2735716535017, 3749.9250015000093, 3757.380032294641, 4231.746095234295, 4241.915161696748, 4262.168877069003, 4272.316429371285, 4298.474041715209, 5036.823711170092, 5039.319691841554, 5041.218611115283, 5052.736815796051, 5056.342675452168, 1279.2388528825334, 1312.566852938528, 1327.82074419954, 1327.9867201327863, 1332.8467226269104, 808.2160304504739, 850.5917159763349, 858.9434994956239, 862.7886167888907, 864.4165188497739, 3950.740638972859, 3952.2095580883365, 3959.8416063357718, 3964.4053391990856, 3964.841406343714, 4487.349334346502, 4532.388127602798, 4534.841280555164, 4544.886377840514, 4567.451905771329, 3947.763134211899, 3950.2297052075146, 3957.9604203957592, 3960.485136932238, 3965.405189221582, 2272.4547307830835, 2444.6455263986622, 2457.6436416719475, 2465.6794616699713, 2470.505898820207, 4315.4605674290715, 4625.468071171791, 4647.814087436533, 4784.808607655725, 4810.11012962603, 5217.50433708797, 5221.947780522222, 5260.34352651916, 5271.446498117719, 5293.682379057269, 4800.359802108896, 4801.399825021872, 4802.135615589227, 4806.567408933212, 4855.36880205571, 4965.751712414437, 5111.948880511296, 5124.256982737556, 5128.923066153936, 5186.170212765939, 4979.701217926936, 4998.300237966615, 5004.949950500449, 5014.674046186986, 5026.47222041695, 4840.782164802663, 4840.854774356775, 4848.151573474698, 4850.95149048505, 4852.296417019583, 3455.274392377629, 3660.2679464106754, 3669.853205871735, 3676.6507181817683, 3683.318586061587, 5201.557867581147, 5206.687598744087, 5216.139337009503, 5223.9477605223465, 5264.89470210586, 5027.949720502748, 5073.416557095981, 5076.18780995039, 5097.6941383517105, 5108.66793658411, 4943.703377797344, 4971.9502804972935, 5011.699298041984, 5024.6231532634465, 5055.418626857959, 4924.72913989734, 4928.162212423825, 4929.975350123226, 4932.383452068491, 4942.6293028023765, 5039.21892106724, 5041.6470847040355, 5044.394672639307, 5049.318342023927, 5055.443901170795, 4757.405324334458, 4980.477049909708, 5013.248012797963, 5015.724135172454, 5021.246812978083], "value": 3739.532313399912, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.6159419565674, 661.7683810666267, 713.1192976673807, 731.8646050480664, 740.844422671239, 11970.700732481693, 12889.162204456727, 12893.0, 12922.09545331826, 12960.15758975666, 12230.51077956883, 12348.4443200056, 12356.938215308934, 12369.752604947897, 12373.381330933462, 616.1650962945212, 636.8121404185753, 731.1153504259826, 776.2509178642608, 784.1531146361915, 785.5208322923041, 788.1763557082862, 789.3211837819471, 789.3685051958411, 789.3842802613971, 647.1748520636179, 843.2916350265775, 846.0397448895517, 846.1158089796178, 847.3560094328324, 670.5641333133453, 821.8520666280098, 842.9536375499345, 843.9451435656663, 852.2031900173296, 612.9264488261438, 613.4846728747873, 614.6987975891781, 616.873540924114, 616.929053158888, 12700.364981750876, 12718.618441446772, 12726.490940362375, 12753.936230318881, 12756.744865102739, 12948.611541653765, 12958.0, 13071.346432678329, 13255.867441325656, 13298.135621184592, 10039.74900627483, 10076.798464030679, 10222.131118854906, 10281.126104281146, 10333.948330258301, 3305.768596198267, 3308.17295676081, 3348.631650518441, 3363.6636336366414, 3364.5457863188403, 46427.535724643, 46807.76596117032, 48059.519404805855, 48095.278570821465, 48168.0, 8367.707130250412, 8604.268637165911, 8742.475451472932, 8901.421407608485, 8960.68637597681, 15799.289031993589, 15946.362145514282, 15954.04275743436, 15975.520734377988, 16090.195490225442, 6250.0, 6301.6219026858535, 6419.51853610981, 6579.111819904348, 6598.208215014229, 3495.9300813983577, 3542.6103128655827, 3562.1985053363305, 3601.081724160375, 3622.5471816022996, 2597.1039991203006, 2681.410089780245, 2685.9731402685725, 2694.514987302265, 2695.8517281549703, 467.6632824366451, 508.37723788358966, 522.5662699959025, 530.1279395394554, 540.1088204462668, 485.87367284506286, 555.2559570175903, 591.2520661363379, 593.483669207792, 596.2457491273542, 6974.721011159599, 7283.927160728431, 7478.588677622674, 7771.455998080193, 7808.141104478503, 581.8632621333983, 592.1384385718769, 603.7434090511603, 607.7052629474701, 614.3334482086897, 3592.856285748541, 3651.72612054097, 3685.94471082934, 3692.2615476904725, 3763.6989040876665, 65365.0, 69885.65057174783, 70189.29810701827, 70651.3478921685, 72764.27235727682, 59826.0, 63808.68095659492, 65270.347296527376, 65651.67174164098, 65978.0, 56232.718836405555, 56679.0, 57458.712706437036, 57885.421145788845, 58042.12936805951, 7076.433885289061, 7111.745306317815, 7253.347198752138, 7437.735584950679, 7558.962205188939, 33611.49582756212, 34818.0, 35913.0, 36245.27509449849, 37177.4423383644, 47521.52478475171, 49712.29459433794, 50069.74965125151, 50258.497415025384, 50600.49399505958, 9234.630614775333, 9540.95229523848, 9595.0, 9610.0, 9614.855777163208, 10469.424181670081, 10483.737906552396, 10660.375472339441, 10796.406197659204, 10902.454877256265, 9469.573869176042, 9642.276829237975, 9703.563339649592, 10055.145312648214, 10481.0, 10151.340162889388, 10466.267361284637, 10559.328805433664, 10593.0, 10616.044555989998, 10249.641262555775, 10375.16998640122, 10405.583776649151, 10427.374357538572, 10550.683479495627, 8942.37403381757, 9137.725868223964, 9234.26125909939, 9511.809763804824, 9649.951750241204, 8947.552622368985, 9551.188149007412, 9574.856377154209, 9602.327837051618, 9664.613415463584], "value": 5967.848082845394, "unit": "score"}], "name": "dromaeo_css", "value": 6082.349344032013, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 116.0, 115.0, 116.0, 116.0, 114.0, 116.0, 116.0, 116.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 133.0, 172.0, 133.0, 129.0, 131.0, 135.0, 161.0, 127.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 160.0, 161.0, 160.0, 162.0, 161.0, 161.0, 164.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 108.0, 77.0, 76.0, 77.0, 75.0, 98.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 126.0, 84.0, 83.0, 84.0, 113.0, 83.0, 84.0, 111.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 148.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 88.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 61.0, 70.0, 63.0, 61.0, 62.0, 62.0, 64.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 67.0, 65.0, 65.0, 67.0, 66.0, 69.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 83.0, 92.0, 85.0, 83.0, 83.0, 83.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 150.0, 152.0, 139.0, 147.0, 153.0, 148.0, 141.0, 183.0, 143.0], "value": 149.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 182.0, 181.0, 179.0, 182.0, 177.0, 185.0, 177.0, 183.0, 176.0], "value": 180.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 70.0, 70.0, 74.0, 73.0, 71.0, 72.0, 69.0, 70.0], "value": 71.3, "unit": "score"}], "name": "kraken", "value": 1554.6, "alertThreshold": 2.0}]} 07:19:25 INFO - Return code: 0 07:19:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:19:25 INFO - # TBPL SUCCESS # 07:19:25 INFO - Running post-action listener: _resource_record_post_action 07:19:25 INFO - [mozharness: 2016-10-28 14:19:25.484941Z] Finished run-tests step (success) 07:19:25 INFO - Running post-run listener: _resource_record_post_run 07:19:25 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 389652480; Read time: 16; Write time: 352472 07:19:25 INFO - TinderboxPrint: CPU usage
13.1% 07:19:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 07:19:25 INFO - TinderboxPrint: I/O write bytes / time
389,652,480 / 352,472 07:19:25 INFO - TinderboxPrint: CPU idle
8,350.3 (86.9%) 07:19:25 INFO - TinderboxPrint: CPU user
1,204.9 (12.5%) 07:19:25 INFO - TinderboxPrint: Swap in / out
0 / 0 07:19:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 98807808; Read time: 0; Write time: 73004 07:19:25 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 290844672; Read time: 0; Write time: 279468 07:19:26 INFO - Running post-run listener: _upload_blobber_files 07:19:26 INFO - Blob upload gear active. 07:19:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:19:26 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 07:19:26 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:19:26 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:19:26 INFO - (blobuploader) - INFO - Open directory for files ... 07:19:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:19:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:19:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:19:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:19:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:19:30 INFO - (blobuploader) - INFO - Done attempting. 07:19:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:19:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:19:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:19:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:19:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:19:31 INFO - (blobuploader) - INFO - Done attempting. 07:19:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:19:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:19:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:19:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:19:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:19:32 INFO - (blobuploader) - INFO - Done attempting. 07:19:32 INFO - (blobuploader) - INFO - Iteration through files over. 07:19:32 INFO - Return code: 0 07:19:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:19:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:19:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/0fb08e10e9d88746e797a0f87cffd90d93eb7b82cbde406307144da3e63751c30520e5644997054eefbf11f65ea12100e3a039275600dbba01e6fc32851556fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e8ffd9c720530b5c9e5ea4396b9f2c9f99731e29ee9f0529b86624ef270b2102ab0c1d5001b6e950336e05778505e90d6c2122735c3afc6dad0423f9057c782f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/a917ad9019051c4923ebfcc218dad0b74c48bf87741b11a2a8a080b235a54990ecb08fb059c420fbde531b1eb54bba64015958a399548cf925b893d8ba3662c5"} 07:19:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:19:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:19:32 INFO - Contents: 07:19:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/0fb08e10e9d88746e797a0f87cffd90d93eb7b82cbde406307144da3e63751c30520e5644997054eefbf11f65ea12100e3a039275600dbba01e6fc32851556fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e8ffd9c720530b5c9e5ea4396b9f2c9f99731e29ee9f0529b86624ef270b2102ab0c1d5001b6e950336e05778505e90d6c2122735c3afc6dad0423f9057c782f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/a917ad9019051c4923ebfcc218dad0b74c48bf87741b11a2a8a080b235a54990ecb08fb059c420fbde531b1eb54bba64015958a399548cf925b893d8ba3662c5"} 07:19:32 INFO - Running post-run listener: copy_logs_to_upload_dir 07:19:32 INFO - Copying logs to upload dir... 07:19:32 INFO - mkdir: /builds/slave/test/build/upload/logs 07:19:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.269570 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-28 07:19:32.176454) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 07:19:32.179951) ========= 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=d2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/0fb08e10e9d88746e797a0f87cffd90d93eb7b82cbde406307144da3e63751c30520e5644997054eefbf11f65ea12100e3a039275600dbba01e6fc32851556fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e8ffd9c720530b5c9e5ea4396b9f2c9f99731e29ee9f0529b86624ef270b2102ab0c1d5001b6e950336e05778505e90d6c2122735c3afc6dad0423f9057c782f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/a917ad9019051c4923ebfcc218dad0b74c48bf87741b11a2a8a080b235a54990ecb08fb059c420fbde531b1eb54bba64015958a399548cf925b893d8ba3662c5"} build_url:https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/LqzKl0exRkiY6JgDpOMa0g/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/Cedar/sha512/0fb08e10e9d88746e797a0f87cffd90d93eb7b82cbde406307144da3e63751c30520e5644997054eefbf11f65ea12100e3a039275600dbba01e6fc32851556fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e8ffd9c720530b5c9e5ea4396b9f2c9f99731e29ee9f0529b86624ef270b2102ab0c1d5001b6e950336e05778505e90d6c2122735c3afc6dad0423f9057c782f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/a917ad9019051c4923ebfcc218dad0b74c48bf87741b11a2a8a080b235a54990ecb08fb059c420fbde531b1eb54bba64015958a399548cf925b893d8ba3662c5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 07:19:32.210519) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 07:19:32.210877) ========= 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=d2a8c569965ab8367867b893000001a1-1477663121.548168-1321923383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004403 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 07:19:32.293737) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 07:19:32.294243) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 07:19:32.294790) ========= ========= Total master_lag: 0.19 =========